builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1453089672.5 results: success (0) buildid: 20160117173002 builduid: 1bcb7f57368e472a97a51a66087c28d2 revision: 3e880d2651f98e22634003a9923a50b6668d896b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:12.502630) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:12.503139) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:12.503475) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006379 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.14 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:12.645012) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:12.645346) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:12.675570) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:12.675934) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004634 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:12.763175) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:12.763477) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:12.763850) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:12.764154) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-17 20:01:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 77.6M=0s 2016-01-17 20:01:13 (77.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.098865 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:12.896680) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:12.896993) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018321 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:12.997745) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-17 20:01:12.998093) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 3e880d2651f98e22634003a9923a50b6668d896b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 3e880d2651f98e22634003a9923a50b6668d896b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-17 20:01:13,397 truncating revision to first 12 chars 2016-01-17 20:01:13,397 Setting DEBUG logging. 2016-01-17 20:01:13,397 attempt 1/10 2016-01-17 20:01:13,397 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/3e880d2651f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-17 20:01:14,733 unpacking tar archive at: fx-team-3e880d2651f9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.628323 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-17 20:01:14.653015) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:14.653366) ========= echo '%(revision)s' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', '%(revision)s'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False %(revision)s program finished with exit code 0 elapsedTime=0.004159 script_repo_revision: '%(revision)s' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:14.702955) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:14.703292) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:14.713106) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:14.713383) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/%(revision)s ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-17 20:01:14.713819) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-17 20:01:14.714135) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:01:15 INFO - MultiFileLogger online at 20160117 20:01:15 in /builds/slave/test-pgo 20:01:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:01:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 20:01:15 INFO - {'append_to_log': False, 20:01:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 20:01:15 INFO - 'blob_upload_branch': 'Fx-Team', 20:01:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 20:01:15 INFO - 'branch': 'Fx-Team', 20:01:15 INFO - 'buildbot_json_path': 'buildprops.json', 20:01:15 INFO - 'config_files': ('talos/linux_config.py',), 20:01:15 INFO - 'default_actions': ('clobber', 20:01:15 INFO - 'read-buildbot-config', 20:01:15 INFO - 'download-and-extract', 20:01:15 INFO - 'populate-webroot', 20:01:15 INFO - 'create-virtualenv', 20:01:15 INFO - 'install', 20:01:15 INFO - 'run-tests'), 20:01:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:01:15 INFO - 'download_minidump_stackwalk': True, 20:01:15 INFO - 'download_symbols': 'ondemand', 20:01:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:01:15 INFO - 'tooltool.py': '/tools/tooltool.py', 20:01:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:01:15 INFO - '/tools/misc-python/virtualenv.py')}, 20:01:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:01:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:01:15 INFO - 'installer_path': 'installer.exe', 20:01:15 INFO - 'log_level': 'info', 20:01:15 INFO - 'log_name': 'talos', 20:01:15 INFO - 'log_to_console': True, 20:01:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:01:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:01:15 INFO - 'opt_config_files': (), 20:01:15 INFO - 'pip_index': False, 20:01:15 INFO - 'sps_profile': False, 20:01:15 INFO - 'sps_profile_interval': 0, 20:01:15 INFO - 'suite': 'dromaeojs-e10s', 20:01:15 INFO - 'system_bits': '32', 20:01:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:01:15 INFO - 'title': 'talos-linux64-ix-037', 20:01:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:01:15 INFO - 'use_talos_json': True, 20:01:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 20:01:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:01:15 INFO - 'work_dir': 'build'} 20:01:15 INFO - ##### 20:01:15 INFO - ##### Running clobber step. 20:01:15 INFO - ##### 20:01:15 INFO - Running pre-action listener: _resource_record_pre_action 20:01:15 INFO - Running main action method: clobber 20:01:15 INFO - rmtree: /builds/slave/test-pgo/build 20:01:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 20:01:16 INFO - Running post-action listener: _resource_record_post_action 20:01:16 INFO - ##### 20:01:16 INFO - ##### Running read-buildbot-config step. 20:01:16 INFO - ##### 20:01:16 INFO - Running pre-action listener: _resource_record_pre_action 20:01:16 INFO - Running main action method: read_buildbot_config 20:01:16 INFO - Using buildbot properties: 20:01:16 INFO - { 20:01:16 INFO - "project": "", 20:01:16 INFO - "product": "firefox", 20:01:16 INFO - "script_repo_revision": "production", 20:01:16 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:01:16 INFO - "repository": "", 20:01:16 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:01:16 INFO - "buildid": "20160117173002", 20:01:16 INFO - "pgo_build": "True", 20:01:16 INFO - "basedir": "/builds/slave/test-pgo", 20:01:16 INFO - "buildnumber": 215, 20:01:16 INFO - "slavename": "talos-linux64-ix-037", 20:01:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:01:16 INFO - "platform": "ubuntu64_hw", 20:01:16 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:01:16 INFO - "branch": "fx-team", 20:01:16 INFO - "repo_path": "integration/fx-team", 20:01:16 INFO - "revision": "3e880d2651f98e22634003a9923a50b6668d896b", 20:01:16 INFO - "stage_platform": "linux64-pgo", 20:01:16 INFO - "builduid": "1bcb7f57368e472a97a51a66087c28d2", 20:01:16 INFO - "slavebuilddir": "test" 20:01:16 INFO - } 20:01:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 20:01:16 INFO - Running post-action listener: _resource_record_post_action 20:01:16 INFO - ##### 20:01:16 INFO - ##### Running download-and-extract step. 20:01:16 INFO - ##### 20:01:16 INFO - Running pre-action listener: _resource_record_pre_action 20:01:16 INFO - Running main action method: download_and_extract 20:01:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 20:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:16 INFO - https://queue.taskcluster.net/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:01:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/test_packages.json 20:01:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/test_packages.json 20:01:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 20:01:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 20:01:17 INFO - Downloaded 1448 bytes. 20:01:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 20:01:17 INFO - Using the following test package requirements: 20:01:17 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:01:17 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:01:17 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:01:17 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:17 INFO - u'jsshell-linux-x86_64.zip'], 20:01:17 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:01:17 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:01:17 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:01:17 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:01:17 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:01:17 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:01:17 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:01:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:01:17 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:01:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:17 INFO - https://queue.taskcluster.net/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:01:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:01:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:01:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:01:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:01:20 INFO - Downloaded 22484059 bytes. 20:01:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:01:20 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 20:01:21 INFO - Return code: 0 20:01:21 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:01:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:21 INFO - https://queue.taskcluster.net/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:01:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:01:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:01:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:01:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:01:27 INFO - Downloaded 22484059 bytes. 20:01:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:01:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 20:01:28 INFO - Return code: 0 20:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:28 INFO - https://queue.taskcluster.net/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:01:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:01:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:01:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:01:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:01:30 INFO - Downloaded 11132144 bytes. 20:01:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 20:01:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 20:01:30 INFO - Return code: 0 20:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:30 INFO - https://queue.taskcluster.net/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:01:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:01:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:01:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:01:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:01:33 INFO - Downloaded 55962921 bytes. 20:01:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:01:33 INFO - mkdir: /builds/slave/test-pgo/properties 20:01:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:01:33 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:01:33 INFO - Contents: 20:01:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:01:33 INFO - Running post-action listener: _resource_record_post_action 20:01:33 INFO - Running post-action listener: set_extra_try_arguments 20:01:33 INFO - ##### 20:01:33 INFO - ##### Running populate-webroot step. 20:01:33 INFO - ##### 20:01:33 INFO - Running pre-action listener: _resource_record_pre_action 20:01:33 INFO - Running main action method: populate_webroot 20:01:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:01:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:01:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:01:33 INFO - '--tppagecycles', 20:01:33 INFO - '7'], 20:01:33 INFO - 'tests': ['tsvgm']}}, 20:01:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:01:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:01:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:01:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:01:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:01:33 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:01:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:01:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:33 INFO - 'talos_options': ['--e10s'], 20:01:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:01:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:33 INFO - 'tests': ['damp', 'tps']}, 20:01:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:33 INFO - 'talos_options': ['--e10s'], 20:01:33 INFO - 'tests': ['damp', 'tps']}, 20:01:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:01:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:01:33 INFO - 'other': {'tests': ['a11yr', 20:01:33 INFO - 'ts_paint', 20:01:33 INFO - 'tpaint', 20:01:33 INFO - 'sessionrestore', 20:01:33 INFO - 'sessionrestore_no_auto_restore']}, 20:01:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:01:33 INFO - 'tests': ['a11yr', 20:01:33 INFO - 'ts_paint', 20:01:33 INFO - 'tpaint', 20:01:33 INFO - 'sessionrestore', 20:01:33 INFO - 'sessionrestore_no_auto_restore']}, 20:01:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:01:33 INFO - 'tests': ['a11yr', 20:01:33 INFO - 'ts_paint', 20:01:33 INFO - 'tpaint', 20:01:33 INFO - 'sessionrestore', 20:01:33 INFO - 'sessionrestore_no_auto_restore']}, 20:01:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:01:33 INFO - 'tests': ['a11yr', 20:01:33 INFO - 'ts_paint', 20:01:33 INFO - 'tpaint', 20:01:33 INFO - 'sessionrestore', 20:01:33 INFO - 'sessionrestore_no_auto_restore']}, 20:01:33 INFO - 'other_l64': {'tests': ['a11yr', 20:01:33 INFO - 'ts_paint', 20:01:33 INFO - 'tpaint', 20:01:33 INFO - 'sessionrestore', 20:01:33 INFO - 'sessionrestore_no_auto_restore']}, 20:01:33 INFO - 'other_nol64': {'tests': ['a11yr', 20:01:33 INFO - 'ts_paint', 20:01:33 INFO - 'tpaint', 20:01:33 INFO - 'sessionrestore', 20:01:33 INFO - 'sessionrestore_no_auto_restore']}, 20:01:33 INFO - 'svgr': {'tests': ['tsvgx', 20:01:33 INFO - 'tsvgr_opacity', 20:01:33 INFO - 'tart', 20:01:33 INFO - 'tscrollx', 20:01:33 INFO - 'cart']}, 20:01:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:01:33 INFO - 'tests': ['tsvgx', 20:01:33 INFO - 'tsvgr_opacity', 20:01:33 INFO - 'tart', 20:01:33 INFO - 'tscrollx', 20:01:33 INFO - 'cart']}, 20:01:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:33 INFO - 'tests': ['tp5o']}, 20:01:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:33 INFO - 'talos_options': ['--e10s'], 20:01:33 INFO - 'tests': ['tp5o']}, 20:01:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:33 INFO - 'talos_options': ['--xperf_path', 20:01:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:01:33 INFO - 'tests': ['tp5n']}, 20:01:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:01:33 INFO - 'talos_options': ['--e10s', 20:01:33 INFO - '--xperf_path', 20:01:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:01:33 INFO - 'tests': ['tp5n']}}, 20:01:33 INFO - 'talos.zip': {'path': '', 20:01:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:01:33 INFO - Running post-action listener: _resource_record_post_action 20:01:33 INFO - ##### 20:01:33 INFO - ##### Running create-virtualenv step. 20:01:33 INFO - ##### 20:01:33 INFO - Running pre-action listener: _resource_record_pre_action 20:01:33 INFO - Running main action method: create_virtualenv 20:01:33 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:01:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 20:01:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:01:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:01:33 INFO - Using real prefix '/usr' 20:01:33 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:01:34 INFO - Installing distribute.............................................................................................................................................................................................done. 20:01:36 INFO - Installing pip.................done. 20:01:36 INFO - Return code: 0 20:01:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6806079f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1906480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1995660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1996a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:01:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 20:01:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:01:36 INFO - Using env: {'DISPLAY': ':0', 20:01:36 INFO - 'HOME': '/home/cltbld', 20:01:36 INFO - 'LANG': 'en_US.UTF-8', 20:01:36 INFO - 'LANGUAGE': 'en_US:en', 20:01:36 INFO - 'LOGNAME': 'cltbld', 20:01:36 INFO - 'MAIL': '/var/mail/cltbld', 20:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:36 INFO - 'MOZ_NO_REMOTE': '1', 20:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:36 INFO - 'NO_EM_RESTART': '1', 20:01:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:36 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:36 INFO - 'SHELL': '/bin/bash', 20:01:36 INFO - 'SHLVL': '1', 20:01:36 INFO - 'TERM': 'linux', 20:01:36 INFO - 'TMOUT': '86400', 20:01:36 INFO - 'USER': 'cltbld', 20:01:36 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 20:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:36 INFO - '_': '/tools/buildbot/bin/python'} 20:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:01:36 INFO - Cleaning up... 20:01:36 INFO - Return code: 0 20:01:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6806079f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1906480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1995660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1996a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:01:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 20:01:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:01:36 INFO - Using env: {'DISPLAY': ':0', 20:01:36 INFO - 'HOME': '/home/cltbld', 20:01:36 INFO - 'LANG': 'en_US.UTF-8', 20:01:36 INFO - 'LANGUAGE': 'en_US:en', 20:01:36 INFO - 'LOGNAME': 'cltbld', 20:01:36 INFO - 'MAIL': '/var/mail/cltbld', 20:01:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:36 INFO - 'MOZ_NO_REMOTE': '1', 20:01:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:36 INFO - 'NO_EM_RESTART': '1', 20:01:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:36 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:36 INFO - 'SHELL': '/bin/bash', 20:01:36 INFO - 'SHLVL': '1', 20:01:36 INFO - 'TERM': 'linux', 20:01:36 INFO - 'TMOUT': '86400', 20:01:36 INFO - 'USER': 'cltbld', 20:01:36 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 20:01:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:36 INFO - '_': '/tools/buildbot/bin/python'} 20:01:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:36 INFO - Downloading/unpacking psutil>=0.7.1 20:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:38 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 20:01:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:01:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:01:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:01:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:01:38 INFO - Installing collected packages: psutil 20:01:38 INFO - Running setup.py install for psutil 20:01:38 INFO - building 'psutil._psutil_linux' extension 20:01:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:01:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:01:38 INFO - building 'psutil._psutil_posix' extension 20:01:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:01:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:01:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:01:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:01:39 INFO - Successfully installed psutil 20:01:39 INFO - Cleaning up... 20:01:39 INFO - Return code: 0 20:01:39 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6806079f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1906480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1995660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1996a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:01:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 20:01:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:01:39 INFO - Using env: {'DISPLAY': ':0', 20:01:39 INFO - 'HOME': '/home/cltbld', 20:01:39 INFO - 'LANG': 'en_US.UTF-8', 20:01:39 INFO - 'LANGUAGE': 'en_US:en', 20:01:39 INFO - 'LOGNAME': 'cltbld', 20:01:39 INFO - 'MAIL': '/var/mail/cltbld', 20:01:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:39 INFO - 'MOZ_NO_REMOTE': '1', 20:01:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:39 INFO - 'NO_EM_RESTART': '1', 20:01:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:39 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:39 INFO - 'SHELL': '/bin/bash', 20:01:39 INFO - 'SHLVL': '1', 20:01:39 INFO - 'TERM': 'linux', 20:01:39 INFO - 'TMOUT': '86400', 20:01:39 INFO - 'USER': 'cltbld', 20:01:39 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 20:01:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:39 INFO - '_': '/tools/buildbot/bin/python'} 20:01:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:01:41 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:01:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:01:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:01:41 INFO - Installing collected packages: mozsystemmonitor 20:01:41 INFO - Running setup.py install for mozsystemmonitor 20:01:41 INFO - Successfully installed mozsystemmonitor 20:01:41 INFO - Cleaning up... 20:01:41 INFO - Return code: 0 20:01:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:41 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6806079f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1906480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1995660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1996a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:01:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 20:01:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:01:41 INFO - Using env: {'DISPLAY': ':0', 20:01:41 INFO - 'HOME': '/home/cltbld', 20:01:41 INFO - 'LANG': 'en_US.UTF-8', 20:01:41 INFO - 'LANGUAGE': 'en_US:en', 20:01:41 INFO - 'LOGNAME': 'cltbld', 20:01:41 INFO - 'MAIL': '/var/mail/cltbld', 20:01:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:41 INFO - 'MOZ_NO_REMOTE': '1', 20:01:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:41 INFO - 'NO_EM_RESTART': '1', 20:01:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:41 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:41 INFO - 'SHELL': '/bin/bash', 20:01:41 INFO - 'SHLVL': '1', 20:01:41 INFO - 'TERM': 'linux', 20:01:41 INFO - 'TMOUT': '86400', 20:01:41 INFO - 'USER': 'cltbld', 20:01:41 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 20:01:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:41 INFO - '_': '/tools/buildbot/bin/python'} 20:01:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:41 INFO - Downloading/unpacking blobuploader==1.2.4 20:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:43 INFO - Downloading blobuploader-1.2.4.tar.gz 20:01:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:01:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:01:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:01:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:01:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:43 INFO - Downloading docopt-0.6.1.tar.gz 20:01:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:01:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:01:43 INFO - Installing collected packages: blobuploader, requests, docopt 20:01:43 INFO - Running setup.py install for blobuploader 20:01:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:01:44 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:01:44 INFO - Running setup.py install for requests 20:01:44 INFO - Running setup.py install for docopt 20:01:44 INFO - Successfully installed blobuploader requests docopt 20:01:44 INFO - Cleaning up... 20:01:44 INFO - Return code: 0 20:01:44 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6806079f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1906480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1995660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1996a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:01:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 20:01:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:01:44 INFO - Using env: {'DISPLAY': ':0', 20:01:44 INFO - 'HOME': '/home/cltbld', 20:01:44 INFO - 'LANG': 'en_US.UTF-8', 20:01:44 INFO - 'LANGUAGE': 'en_US:en', 20:01:44 INFO - 'LOGNAME': 'cltbld', 20:01:44 INFO - 'MAIL': '/var/mail/cltbld', 20:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:44 INFO - 'MOZ_NO_REMOTE': '1', 20:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:44 INFO - 'NO_EM_RESTART': '1', 20:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:44 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:44 INFO - 'SHELL': '/bin/bash', 20:01:44 INFO - 'SHLVL': '1', 20:01:44 INFO - 'TERM': 'linux', 20:01:44 INFO - 'TMOUT': '86400', 20:01:44 INFO - 'USER': 'cltbld', 20:01:44 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 20:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:44 INFO - '_': '/tools/buildbot/bin/python'} 20:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:01:44 INFO - Running setup.py (path:/tmp/pip-UJ5cjW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:01:44 INFO - Running setup.py (path:/tmp/pip-FSNorZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:01:44 INFO - Running setup.py (path:/tmp/pip-gHzIuS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:01:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:01:44 INFO - Running setup.py (path:/tmp/pip-TnodQZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:01:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:01:45 INFO - Running setup.py (path:/tmp/pip-wqTVv9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:01:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:01:45 INFO - Running setup.py (path:/tmp/pip-mujbl6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:01:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:01:45 INFO - Running setup.py (path:/tmp/pip-H3kEuV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:01:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:01:45 INFO - Running setup.py (path:/tmp/pip-Ffhdie-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:01:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:01:45 INFO - Running setup.py (path:/tmp/pip-GdFHX5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:01:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:01:45 INFO - Running setup.py (path:/tmp/pip-9PHQmu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:01:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:01:45 INFO - Running setup.py (path:/tmp/pip-8Ofi3j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:01:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:01:45 INFO - Running setup.py (path:/tmp/pip-9drON6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:01:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:01:45 INFO - Running setup.py (path:/tmp/pip-9G2ifx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:01:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:01:45 INFO - Running setup.py (path:/tmp/pip-CDmY6b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:01:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:01:45 INFO - Running setup.py (path:/tmp/pip-X3P4Fg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:01:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:01:45 INFO - Running setup.py (path:/tmp/pip-SmY47T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:01:45 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:01:45 INFO - Running setup.py (path:/tmp/pip-sMcoK9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:01:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:01:45 INFO - Running setup.py install for manifestparser 20:01:46 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:01:46 INFO - Running setup.py install for mozcrash 20:01:46 INFO - Running setup.py install for mozdebug 20:01:46 INFO - Running setup.py install for mozdevice 20:01:46 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:01:46 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:01:46 INFO - Running setup.py install for mozfile 20:01:46 INFO - Running setup.py install for mozhttpd 20:01:46 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:01:46 INFO - Running setup.py install for mozinfo 20:01:46 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:01:46 INFO - Running setup.py install for mozInstall 20:01:46 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:01:46 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:01:46 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:01:46 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:01:46 INFO - Running setup.py install for mozleak 20:01:46 INFO - Running setup.py install for mozlog 20:01:46 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:01:46 INFO - Running setup.py install for moznetwork 20:01:47 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:01:47 INFO - Running setup.py install for mozprocess 20:01:47 INFO - Running setup.py install for mozprofile 20:01:47 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:01:47 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:01:47 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:01:47 INFO - Running setup.py install for mozrunner 20:01:47 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:01:47 INFO - Running setup.py install for mozscreenshot 20:01:47 INFO - Running setup.py install for moztest 20:01:47 INFO - Running setup.py install for mozversion 20:01:47 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:01:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:01:47 INFO - Cleaning up... 20:01:47 INFO - Return code: 0 20:01:47 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6806079f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1906480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1995660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1996a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:01:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 20:01:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:01:47 INFO - Using env: {'DISPLAY': ':0', 20:01:47 INFO - 'HOME': '/home/cltbld', 20:01:47 INFO - 'LANG': 'en_US.UTF-8', 20:01:47 INFO - 'LANGUAGE': 'en_US:en', 20:01:47 INFO - 'LOGNAME': 'cltbld', 20:01:47 INFO - 'MAIL': '/var/mail/cltbld', 20:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:47 INFO - 'MOZ_NO_REMOTE': '1', 20:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:47 INFO - 'NO_EM_RESTART': '1', 20:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:47 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:47 INFO - 'SHELL': '/bin/bash', 20:01:47 INFO - 'SHLVL': '1', 20:01:47 INFO - 'TERM': 'linux', 20:01:47 INFO - 'TMOUT': '86400', 20:01:47 INFO - 'USER': 'cltbld', 20:01:47 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 20:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:47 INFO - '_': '/tools/buildbot/bin/python'} 20:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:01:47 INFO - Running setup.py (path:/tmp/pip-71TtZQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 20:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:01:48 INFO - Running setup.py (path:/tmp/pip-7KbBd1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:01:48 INFO - Running setup.py (path:/tmp/pip-E6DQgC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 20:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:01:48 INFO - Running setup.py (path:/tmp/pip-T2jvZM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:01:48 INFO - Running setup.py (path:/tmp/pip-OZ1XE2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 20:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:01:48 INFO - Running setup.py (path:/tmp/pip-VzcBfp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 20:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:01:48 INFO - Running setup.py (path:/tmp/pip-NHx21i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 20:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:01:48 INFO - Running setup.py (path:/tmp/pip-Qifajs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 20:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:01:48 INFO - Running setup.py (path:/tmp/pip-TLx8iX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 20:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:01:48 INFO - Running setup.py (path:/tmp/pip-TjVmAT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:01:48 INFO - Running setup.py (path:/tmp/pip-g43PcP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 20:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:01:48 INFO - Running setup.py (path:/tmp/pip-6hyk1d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 20:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:01:48 INFO - Running setup.py (path:/tmp/pip-D7IE7a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 20:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:01:48 INFO - Running setup.py (path:/tmp/pip-G87ZXO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:01:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 20:01:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:01:48 INFO - Running setup.py (path:/tmp/pip-vjdqq5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 20:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:01:49 INFO - Running setup.py (path:/tmp/pip-pKfMuq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 20:01:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:01:49 INFO - Running setup.py (path:/tmp/pip-nBWAws-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 20:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 20:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 20:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 20:01:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:50 INFO - Downloading blessings-1.5.1.tar.gz 20:01:50 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 20:01:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:01:50 INFO - Installing collected packages: blessings 20:01:50 INFO - Running setup.py install for blessings 20:01:51 INFO - Successfully installed blessings 20:01:51 INFO - Cleaning up... 20:01:51 INFO - Return code: 0 20:01:51 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:01:51 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:01:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:01:51 INFO - Reading from file tmpfile_stdout 20:01:51 INFO - Current package versions: 20:01:51 INFO - argparse == 1.2.1 20:01:51 INFO - blessings == 1.5.1 20:01:51 INFO - blobuploader == 1.2.4 20:01:51 INFO - docopt == 0.6.1 20:01:51 INFO - manifestparser == 1.1 20:01:51 INFO - mozInstall == 1.12 20:01:51 INFO - mozcrash == 0.16 20:01:51 INFO - mozdebug == 0.1 20:01:51 INFO - mozdevice == 0.48 20:01:51 INFO - mozfile == 1.2 20:01:51 INFO - mozhttpd == 0.7 20:01:51 INFO - mozinfo == 0.9 20:01:51 INFO - mozleak == 0.1 20:01:51 INFO - mozlog == 3.1 20:01:51 INFO - moznetwork == 0.27 20:01:51 INFO - mozprocess == 0.22 20:01:51 INFO - mozprofile == 0.28 20:01:51 INFO - mozrunner == 6.11 20:01:51 INFO - mozscreenshot == 0.1 20:01:51 INFO - mozsystemmonitor == 0.0 20:01:51 INFO - moztest == 0.7 20:01:51 INFO - mozversion == 1.4 20:01:51 INFO - psutil == 3.1.1 20:01:51 INFO - requests == 1.2.3 20:01:51 INFO - wsgiref == 0.1.2 20:01:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6806079f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1906480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1995660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1996a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:01:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 20:01:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:01:51 INFO - Using env: {'DISPLAY': ':0', 20:01:51 INFO - 'HOME': '/home/cltbld', 20:01:51 INFO - 'LANG': 'en_US.UTF-8', 20:01:51 INFO - 'LANGUAGE': 'en_US:en', 20:01:51 INFO - 'LOGNAME': 'cltbld', 20:01:51 INFO - 'MAIL': '/var/mail/cltbld', 20:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:51 INFO - 'MOZ_NO_REMOTE': '1', 20:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:51 INFO - 'NO_EM_RESTART': '1', 20:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:51 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:51 INFO - 'SHELL': '/bin/bash', 20:01:51 INFO - 'SHLVL': '1', 20:01:51 INFO - 'TERM': 'linux', 20:01:51 INFO - 'TMOUT': '86400', 20:01:51 INFO - 'USER': 'cltbld', 20:01:51 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 20:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:51 INFO - '_': '/tools/buildbot/bin/python'} 20:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 20:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 20:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 20:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 20:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 20:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 20:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 20:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 20:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 20:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 20:01:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 20:01:51 INFO - Cleaning up... 20:01:51 INFO - Return code: 0 20:01:51 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6806079f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1906480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1995660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1996a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:01:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 20:01:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:01:51 INFO - Using env: {'DISPLAY': ':0', 20:01:51 INFO - 'HOME': '/home/cltbld', 20:01:51 INFO - 'LANG': 'en_US.UTF-8', 20:01:51 INFO - 'LANGUAGE': 'en_US:en', 20:01:51 INFO - 'LOGNAME': 'cltbld', 20:01:51 INFO - 'MAIL': '/var/mail/cltbld', 20:01:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:51 INFO - 'MOZ_NO_REMOTE': '1', 20:01:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:51 INFO - 'NO_EM_RESTART': '1', 20:01:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:51 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:51 INFO - 'SHELL': '/bin/bash', 20:01:51 INFO - 'SHLVL': '1', 20:01:51 INFO - 'TERM': 'linux', 20:01:51 INFO - 'TMOUT': '86400', 20:01:51 INFO - 'USER': 'cltbld', 20:01:51 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 20:01:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:51 INFO - '_': '/tools/buildbot/bin/python'} 20:01:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:51 INFO - Downloading/unpacking jsonschema 20:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:01:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 20:01:53 INFO - Downloading/unpacking functools32 (from jsonschema) 20:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:53 INFO - Downloading functools32-3.2.3-2.tar.gz 20:01:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:01:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:01:53 INFO - warning: no files found matching '*.txt' 20:01:53 INFO - no previously-included directories found matching 'build' 20:01:53 INFO - no previously-included directories found matching 'dist' 20:01:53 INFO - no previously-included directories found matching '.git*' 20:01:53 INFO - Installing collected packages: jsonschema, functools32 20:01:53 INFO - Running setup.py install for functools32 20:01:53 INFO - warning: no files found matching '*.txt' 20:01:53 INFO - no previously-included directories found matching 'build' 20:01:53 INFO - no previously-included directories found matching 'dist' 20:01:53 INFO - no previously-included directories found matching '.git*' 20:01:53 INFO - Successfully installed jsonschema functools32 20:01:53 INFO - Cleaning up... 20:01:53 INFO - Return code: 0 20:01:53 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6806079f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1906480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1995660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1996a10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:01:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 20:01:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:01:53 INFO - Using env: {'DISPLAY': ':0', 20:01:53 INFO - 'HOME': '/home/cltbld', 20:01:53 INFO - 'LANG': 'en_US.UTF-8', 20:01:53 INFO - 'LANGUAGE': 'en_US:en', 20:01:53 INFO - 'LOGNAME': 'cltbld', 20:01:53 INFO - 'MAIL': '/var/mail/cltbld', 20:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:53 INFO - 'MOZ_NO_REMOTE': '1', 20:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:53 INFO - 'NO_EM_RESTART': '1', 20:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:53 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:53 INFO - 'SHELL': '/bin/bash', 20:01:53 INFO - 'SHLVL': '1', 20:01:53 INFO - 'TERM': 'linux', 20:01:53 INFO - 'TMOUT': '86400', 20:01:53 INFO - 'USER': 'cltbld', 20:01:53 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 20:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:53 INFO - '_': '/tools/buildbot/bin/python'} 20:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:54 INFO - Downloading/unpacking flake8 20:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:01:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 20:01:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:01:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 20:01:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 20:01:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:01:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:01:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:01:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:01:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:01:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:01:56 INFO - no previously-included directories found matching 'docs/_build' 20:01:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:01:56 INFO - Running setup.py install for pep8 20:01:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:01:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:01:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:01:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:01:56 INFO - no previously-included directories found matching 'docs/_build' 20:01:56 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:01:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:01:56 INFO - Cleaning up... 20:01:56 INFO - Return code: 0 20:01:56 INFO - Running post-action listener: _resource_record_post_action 20:01:56 INFO - Running post-action listener: _start_resource_monitoring 20:01:56 INFO - Starting resource monitoring. 20:01:56 INFO - ##### 20:01:56 INFO - ##### Running install step. 20:01:56 INFO - ##### 20:01:56 INFO - Running pre-action listener: _resource_record_pre_action 20:01:56 INFO - Running main action method: install 20:01:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:01:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:01:57 INFO - Reading from file tmpfile_stdout 20:01:57 INFO - Detecting whether we're running mozinstall >=1.0... 20:01:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:01:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:01:57 INFO - Reading from file tmpfile_stdout 20:01:57 INFO - Output received: 20:01:57 INFO - Usage: mozinstall [options] installer 20:01:57 INFO - Options: 20:01:57 INFO - -h, --help show this help message and exit 20:01:57 INFO - -d DEST, --destination=DEST 20:01:57 INFO - Directory to install application into. [default: 20:01:57 INFO - "/builds/slave/test-pgo"] 20:01:57 INFO - --app=APP Application being installed. [default: firefox] 20:01:57 INFO - mkdir: /builds/slave/test-pgo/build/application 20:01:57 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 20:01:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 20:02:13 INFO - Reading from file tmpfile_stdout 20:02:13 INFO - Output received: 20:02:13 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:02:13 INFO - Running post-action listener: _resource_record_post_action 20:02:13 INFO - ##### 20:02:13 INFO - ##### Running run-tests step. 20:02:13 INFO - ##### 20:02:13 INFO - Running pre-action listener: _resource_record_pre_action 20:02:13 INFO - Running main action method: run_tests 20:02:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:02:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:02:13 INFO - Python 2.7.3 20:02:13 INFO - Return code: 0 20:02:13 INFO - grabbing minidump binary from tooltool 20:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:02:13 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1995660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1996a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:02:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 20:02:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:02:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:02:13 INFO - Return code: 0 20:02:13 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:02:13 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:02:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:02:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:02:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:02:13 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:02:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:02:14 INFO - Return code: 0 20:02:14 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 20:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:02:14 INFO - Using env: {'DISPLAY': ':0', 20:02:14 INFO - 'HOME': '/home/cltbld', 20:02:14 INFO - 'LANG': 'en_US.UTF-8', 20:02:14 INFO - 'LANGUAGE': 'en_US:en', 20:02:14 INFO - 'LOGNAME': 'cltbld', 20:02:14 INFO - 'MAIL': '/var/mail/cltbld', 20:02:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:02:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:02:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:02:14 INFO - 'MOZ_NO_REMOTE': '1', 20:02:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:02:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:02:14 INFO - 'NO_EM_RESTART': '1', 20:02:14 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:02:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:02:14 INFO - 'PWD': '/builds/slave/test-pgo', 20:02:14 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:02:14 INFO - 'SHELL': '/bin/bash', 20:02:14 INFO - 'SHLVL': '1', 20:02:14 INFO - 'TERM': 'linux', 20:02:14 INFO - 'TMOUT': '86400', 20:02:14 INFO - 'USER': 'cltbld', 20:02:14 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503', 20:02:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:02:14 INFO - '_': '/tools/buildbot/bin/python'} 20:02:14 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:02:14 INFO - mozversion application_buildid: 20160117173002 20:02:14 INFO - mozversion application_changeset: 3e880d2651f98e22634003a9923a50b6668d896b 20:02:14 INFO - mozversion application_display_name: Nightly 20:02:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:02:14 INFO - mozversion application_name: Firefox 20:02:14 INFO - mozversion application_remotingname: firefox 20:02:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:02:14 INFO - mozversion application_vendor: Mozilla 20:02:14 INFO - mozversion application_version: 46.0a1 20:02:14 INFO - mozversion platform_buildid: 20160117173002 20:02:14 INFO - mozversion platform_changeset: 3e880d2651f98e22634003a9923a50b6668d896b 20:02:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:02:14 INFO - mozversion platform_version: 46.0a1 20:02:14 INFO - using testdate: 1453089734 20:02:14 INFO - actual date: 1453089734 20:02:14 INFO - starting webserver on 'localhost:60327' 20:02:14 INFO - SUITE-START | Running 3 tests 20:02:14 INFO - TEST-START | dromaeo_css 20:02:14 INFO - operating with platform_type : linux_ 20:02:14 INFO - Initialising browser for dromaeo_css test... 20:02:14 INFO - TEST-INFO | started process 29311 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSM8X6g/profile http://localhost:60327/getInfo.html) 20:02:17 INFO - PROCESS | 29311 | 20:02:17 INFO - PROCESS | 29311 | (process:29393): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:02:18 INFO - PROCESS | 29311 | __metrics Screen width/height:1600/1200 20:02:18 INFO - PROCESS | 29311 | colorDepth:24 20:02:18 INFO - PROCESS | 29311 | Browser inner width/height: 1024/697 20:02:18 INFO - PROCESS | 29311 | __metrics 20:02:19 INFO - PROCESS | 29311 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:02:19 INFO - TEST-INFO | 29311: exit 0 20:02:19 INFO - Browser initialized. 20:02:19 INFO - Running cycle 1/1 for dromaeo_css test... 20:02:19 INFO - TEST-INFO | started process 29442 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSM8X6g/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:02:20 INFO - PROCESS | 29442 | -- checkerboarding starts below -- 20:02:20 INFO - PROCESS | 29442 | RENDERTRACE 0.039169 rect red 0 0 10 10 // viewport 20:02:20 INFO - PROCESS | 29442 | RENDERTRACE 45.2531 rect brown 0 0 10 10 // page 20:02:20 INFO - PROCESS | 29442 | RENDERTRACE 45.2769 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 20:02:20 INFO - PROCESS | 29442 | Checkerboarded for 1 frames (47.8646 ms), 100 peak, 1 severity. 20:02:21 INFO - PROCESS | 29442 | 20:02:21 INFO - PROCESS | 29442 | (process:29499): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:02:31 INFO - PROCESS | 29442 | RSS: Main: 149442560 20:02:31 INFO - PROCESS | 29442 | 20:03:21 INFO - PROCESS | 29442 | 1453089801288 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:05:30 INFO - PROCESS | 29442 | Cycle 1(1): loaded http://localhost:60327/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60327/tests/dromaeo/cssquery-ext.html) 20:05:31 INFO - PROCESS | 29442 | RSS: Main: 155750400 20:05:31 INFO - PROCESS | 29442 | 20:08:33 INFO - PROCESS | 29442 | Cycle 1(1): loaded http://localhost:60327/tests/dromaeo/cssquery-ext.html (next: http://localhost:60327/tests/dromaeo/cssquery-jquery.html) 20:08:34 INFO - PROCESS | 29442 | RSS: Main: 152064000 20:08:34 INFO - PROCESS | 29442 | 20:11:35 INFO - PROCESS | 29442 | Cycle 1(1): loaded http://localhost:60327/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60327/tests/dromaeo/cssquery-mootools.html) 20:11:36 INFO - PROCESS | 29442 | RSS: Main: 151322624 20:11:36 INFO - PROCESS | 29442 | 20:14:38 INFO - PROCESS | 29442 | Cycle 1(1): loaded http://localhost:60327/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60327/tests/dromaeo/cssquery-prototype.html) 20:14:38 INFO - PROCESS | 29442 | RSS: Main: 149651456 20:14:38 INFO - PROCESS | 29442 | 20:17:41 INFO - PROCESS | 29442 | Cycle 1(1): loaded http://localhost:60327/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60327/tests/dromaeo/cssquery-yui.html) 20:17:41 INFO - PROCESS | 29442 | RSS: Main: 151465984 20:17:41 INFO - PROCESS | 29442 | 20:20:44 INFO - PROCESS | 29442 | Cycle 1(1): loaded http://localhost:60327/tests/dromaeo/cssquery-yui.html (next: http://localhost:60327/tests/dromaeo/cssquery-dojo.html) 20:20:44 INFO - PROCESS | 29442 | RSS: Main: 153186304 20:20:44 INFO - PROCESS | 29442 | 20:20:44 INFO - PROCESS | 29442 | __start_tp_report 20:20:44 INFO - PROCESS | 29442 | _x_x_mozilla_page_load 20:20:44 INFO - PROCESS | 29442 | _x_x_mozilla_page_load_details 20:20:44 INFO - PROCESS | 29442 | |i|pagename|runs| 20:20:44 INFO - PROCESS | 29442 | |0;dojo.html;3203.599550056243;3215.4212241796467;3246.8701251949924;3255.1048461673045;3266.820324882132;5295.443978382272;5344.652597581155;5350.063738845701;5351.625386222966;5352.06338890694;5307.203919412081;5328.440513746049;5406.107992181285;5430.294061771974;5435.83692489226;4638.281066434708;4904.5831104356175;5042.899142017158;5043.722595257259;5075.238714192882;4846.830360937368;4977.402711674604;4988.75056247188;5044.394672639289;5072.289879416866;4858.246971719389;4865.8783530411665;4875.536824001714;4894.583960363373;4900.166971614834;4881.4630390657;4899.485554016848;4899.583535399495;4950.331705219821;4960.776765045545;4830.806767729287;4886.853394398174;4911.459739428696;4915.631327650441;4918.188498897677;5216.530512253916;5264.447233040552;5281;5281.683099014033;5299.33758280215;5803.390643982363;5807.506361959238;5807.796727114531;5808.564357673149;5814.738336774855;5718.628289161191;5767.855803604902;5835.4748072673665;5851.239338885917;5852.67810270435;5357.062514060024;5383.623146379794;5388.973055134738;5431.456854314576;5444.346678398578;5826.766929322865;5852.736626851802;5854.736536855852;5859.882802343929;5869;5629.0712032514175;5629.662220266797;5637.43625637433;5654.85862853432;5710.086386178192;5781.566382521328;5811.709414529257;5819.767209311664;5826.446487583673;5855.180274761537;5608.383077861432;5740.253767010262;5772.249607550992;5801.622894511843;5810.5351571875;5661.405552417019;5752.194692743019;5754.942450575524;5778.422157784188;5816.185733997244;4462;4477.820887164542;4479.395281636937;4499.4150760400935;4535.365048893158;3960.20795840833;3970.285348637273;3975.6223158799867;4019.698522610816;4021.0148513613767;5350.946490535122;5418.701971391532;5420.674759514362;5442.074847275972;5454.209139674725;5717.256756621613;5802.82591522255;5850.3564607893095;5861.032929566573;5905.970470147622;5332.360116786011;5345.679259244458;5355;5387.784488620489;5400.91898621521;4784.138855006132;4890.168671325883;4896.510348965075;4900.313956046157;4945.9752701236985;5915.40845915405;5938.8812223755285;5975.492083172892;6022.307434644984;6038.184845045863;5806.76772929095;5829.271341082364;5834.299884013945;5837.270341207349;5855.2095467113095;5879.7060146993335;5964.940350596438;6049.667268300285;6049.818505444844;6053.303870055;5662.462066103713;5685.687287199244;5744.195812586157;5762.510186634183;5784.595078344475;5773.797917072882;5774.797882074107;5784.595078344475;5790.334111577223;5799.5070419014855;5560.638558493685;5604.8318550443555;5642.830715078554;5645.520130788929;5664.320281566238;5629.6903670298525;5692.402297758676;5696.430356964271;5701.230333905036;5738.196652468741;5528.391876893458;5547.278853749148;5577.414371491097;5591.664500130005;5599.076152434803;5598.188262701967;5648.209250704823;5656.717164141859;5659.943400565941;5695.971520142372;5547.639403438763;5556.083246264321;5558.3607885092115;5585.329760428612;5631.211630371669 20:20:44 INFO - PROCESS | 29442 | |1;ext.html;530.1517571884984;546.3662151903791;567.1634339349458;567.1917517537513;571.140433647361;35619.64380356196;36539.817300913455;36543.269134617294;36615.81692091536;36767.63232367676;40680.38979415311;41043.794781026125;41075.79462102686;41226.381604275884;41363.793181034125;8426.536540490271;8612.612432440555;8624.741257762276;8629.784255393603;8630.784230394227;8373.790655233606;8391.202835730595;8405.915940840605;8605.95697021514;8656.220940115389;8666.30669546438;8715.912840871573;8746.86879696802;8753.212210901018;8757.824843503126;8581.871271930895;8656.567171641424;8658.090900455456;8672.392932494728;8710.259627931633;8495.617697203641;8569.785755356166;8657.307415406753;8672.826543469158;8680.8697869532;39026.41460378097;39293.41059884104;39542.406863897064;39555.80222098871;39566.604333956864;2973.2715484706387;3124.6406663233793;3140.685931406864;3303.0256074458093;3357.7649564530493;29085.272868178254;29219;29600.703992960225;29880;30355.544666830014;3726.496922915399;3817.274717803636;3839.167849450618;3855.1711382052995;3900.921981560353;264422;264520;265061;265629;265881;53709.73145134249;55216;59292.40707592869;59545.40454595485;60812.69593652003;56142;56351.71824140853;56603.71698141565;56604.43395566074;56712.71643641838;15379.615509612126;15420.997635153679;15472.381104755908;15567.988080774714;15589.454369097253;11784.292942423483;11910.761784764256;11920.46357913896;11943.940280298542;11946.402679866145;19758.90120549388;20040.098195581235;20807.8959605201;20809.27167549159;20986.47533811667;7198.316159964795;7377.151627562792;7405.8889116663295;7440.925590744131;7464.216257292906;878.3105262369137;922.114769820966;942.4486675294892;943.9575219115156;957.5355952363099;29191;29233.32266837296;29433.55849662257;29583.556246656317;29727.25681857971;1007.0684616729496;1045.8640376751125;1073.9140868730483;1079.384750692098;1121.198343184627;14411.567652970427;14708.779368309484;14826;14885.80973766347;14885.92557037208;307892;312837;312896;313132;313402;52935.20597191045;52957.7352113237;52977;53134;53292.733536332846;1337.8461476930277;1344.1061693973593;1346.4344975110478;1347.3869389427787;1360.2314692198877;27961;28120.578191327557;28656.57015144733;28692.42615147727;29092;47318.76340618275;47336;47593.52406475891;47834;48046;203849;205695;206361;206483;207385;31017;32629;33119.83440082784;33129.668703313626;33161.66838331586;38999;43711.78144109259;44759;45590.77204613956;46673.53326466692;34296.628134875325;34750;34950;34985.30029399347;36060.639393606776;34991.475127872596;34993.65006349904;35273;35489.290214195054;35550;35322.823385882904;36545.26909461849;37380.25239495249;37433.25133497261;37450.625493744716;28333;30778.846105769328;30866.382672346877;31297.687023129478;31366.020228078298;23569.64645530284;24043.759562404153;25340.493190135727;25365.74634253634;26330.73669263283 20:20:44 INFO - PROCESS | 29442 | |2;jquery.html;352.73016142650863;356.90363601827494;357.71204180634595;358.0386661813031;359.60443512136646;15674.373025078998;16162.595935101614;16917.7462338065;17182.914085429587;17626.823731762677;11052.613158539452;11513.827292590619;16758.58103547409;16790.160491975414;16826.747598786027;4592.701474404162;5284.207368894658;5299.735013249341;5314.149736042234;5322.148456247001;4708.964027913854;5015.322931404268;5190.558802501791;5282.894342113155;5289.788408463657;5346.625736198468;5357.464253574651;5404.729763511828;5646.153077038456;5676.631018983773;5545.473180047889;5685.289338832646;5730.226419433365;5960.539667781378;5966;5294.867628309285;5308.70802105884;5313.920291195635;5322.121849894763;5336.706481143536;16895.493135205965;19278.32525861602;19921.402357929284;20170.39488815338;20387.89806050975;1920.5486710622993;1965.8918759468224;2088.4674408025858;2102.5479521902867;2244.831637627168;9452.054794520562;9496.240300775922;9541.188998935098;9582.808343833154;9672.22622190223;1797.3888877781487;1813.7007393780011;1824.3067634298882;1824.8266414690584;1890.6596812573732;55478;57952.42047579512;57956.420435795524;58359.83280334412;58591.41408585945;9729.513524323755;9851.802963940825;9883.703488895344;9929.900700993043;10027;12467.5012999479;12563.309018004098;12563.937180314222;12571.5599954003;12584.874151258553;7338.486305958531;7344.889826652605;7365.447591430664;7373.29953654402;7411.888821667571;7054.682539285642;7077.469189810682;7101.467389945775;7103.076600041962;7128.144622645315;4383.956160438419;4386.4736231652405;4425.535318791545;4437.866863994085;4496.7301961882395;1701.3109690575088;1770.6016146366965;1771.7430972508914;1831.752713383676;1869.1495369606796;919.4391421233042;944.7071407863584;970.4710932541782;985.4875464758286;998.9610804762965;14419.206943617992;15253.771193432107;15278.541643750705;15729.764053539206;15784.210789460481;907.8184363127401;914.5884352041608;960.7934294126796;975.4976187263564;977.7946631207384;9028.593713282919;9128.40665356763;9250.86123708145;9334.953325233466;9712.854307185256;531973;538906;547523;554247;560355;71138;71212.64393678102;71959.2804071963;72105.31315464478;73160.26839731641;1150.8791576884307;1180.9822852657217;1189.8096304591224;1190.2739329009298;1192.5051103792002;14776.33506492189;14946.402143914556;15007.32467038964;15334.463293784664;15651.608709782347;32817.83591082029;33363.666363337026;33582.32835343328;34068.318633627685;34794.78218262349;42949.1410171801;43079;43164.568354317315;43921.34117988169;44035.77982110069;7060.470464715064;7266.1280646322775;7371.963140184479;7469.253074692488;7516.774496765106;9423.057694230522;10490.580376784843;11010.39442830652;11128.888711112786;11390.715232119263;8894.866577001221;9036.774080648036;9601.951990240004;9602.08780165883;9637.42175469474;9456.19622332082;9552.761180970532;9617.374870633386;9985.550650220903;10123.139533139765;9250.074992500697;9331.346805723535;9494.335396522178;9522.619095236112;9605.711828645151;7327.303906128909;7501.174870764103;7538.396928245617;7591.772246832604;7630.961845190961;8627.91372086271;9741.172000380047;9873.407595544002;10023.849642255518;10061.748456288651 20:20:44 INFO - PROCESS | 29442 | |3;mootools.html;1487.3753023730035;1509.1850400783574;1675.2377668160989;1782.1801971093296;1812.3475548802428;7372.3364897159245;7462.365698915592;7633.389328853692;7646.044244469442;7682.807929801751;7464.365528930034;7514.211007844179;7518.54888706678;7593.126790419104;7593.2027137150635;2322.256877799105;2335.2177020698086;2344.9062037518565;2346.741858395575;2348.8590684558894;2317.6523521471745;2327.1156960355124;2336.9532609347802;2359.4337359033793;2368.8933997970134;2245.8203343732544;2313.375388645065;2317.03842905195;2321.9535609287886;2337.1002164166835;2294.9426264343356;2332.323626148415;2367.1596583213054;2368.1119580157356;2375.192434572245;2377.2868139558063;2388.0805889732405;2391.091385273602;2397.412633904687;2399.964000539976;7293.0519032525435;7353.48525603208;7377.852442951111;7382.22486638906;7399.3710534604625;4681.46163191234;4725.40932383452;4749.691270067435;4763.571278584909;4788.976055119737;3109.455845227076;3157.5579418881375;3201.3597280543986;3203.423383790917;3211.550382946366;1000.229823036258;1008.6806159411294;1013.6705570689481;1022.437659287389;1048.5229220704562;10348.896511034944;10387.428691421968;10467.371957682564;10471.581136754521;10485.318454300523;4184.2468355695655;4260.616544511009;4317.633001194934;4325;4353.717008394444;8459.069502354736;8462.534560599102;8464.195901389357;8474.703385381605;8484.448510846774;4662.137504561599;4688.4373875134515;4693.835715749932;4709.717416954925;4725.40932383452;4308.202982448257;4312.353147027971;4335.7181783184;4362.367456718758;4370.890727731832;3444.50054742061;3450.810205438675;3452.5339079224486;3480.564929383827;3488.3720930232294;1068.6847380022912;1078.229066217658;1099.8350247462783;1101.1906248907046;1126.9943650281696;1311.6065180445828;1315.5724389573236;1315.8223639808502;1327.0312671749484;1346.1048402812216;7047.365737083687;7146.142462904485;7174.820629484305;7176.246494118147;7188.137423509108;1126.1272513801705;1133.8355938388888;1140.520981187903;1141.8629764428322;1147.0536807134147;5583.664980101207;5722.914156287659;5794.101914203306;5814.912776308359;5818.79634212809;8933.19601235892;9113.863292050624;9403.623855045722;9449.574769135406;9491;9154.450732956044;9247.445153290824;9255.722328330161;9268.768280793034;9302.069793020644;7047.647617619098;7172.354488096096;7173.605451700102;7187.2453392393045;7192.31672991065;6908.447324214151;6930.792076237721;6951.582905025714;6978.302169782981;6983.406410455168;8034.995625546807;8049.074356449083;8178.754637360888;8200.220979006985;8298.502089874626;8235;8366.288865446506;8408.411411201158;8413.158684131538;8423;6337.651429171256;6409.935900640934;6577.309382514767;6579.407853293226;6589.17635295588;7233.602151881697;7236.312550307923;7250.854982900418;7263.491555591269;7311.634418279171;6666.533342666161;6787.762428314985;6815.216250131299;6975.9302406975285;7059.5764254144915;6473.805785826433;6480.44916182111;6503.73985040612;6605.273419923708;6623.4038936495945;6787.762428314985;6801;6802.591844489347;6821.693023814039;6822.044913712183;6158.107074474086;6245.656488893154;6272.121902933502;6312.116303717391;6321.367863213642;6192.659403732838;6269.843253918506;6270.6864656766065;6274.780382686584;6287.2769631492965 20:20:44 INFO - PROCESS | 29442 | |4;prototype.html;328.4383703866388;332.4033360118587;333.9532465454835;337.86823138975797;338.70701842905896;6219.098230756537;6232.750689972401;6266.091416744575;6308.085327627503;6445.097686323918;6220.129181914535;6260.154879091333;6266.905996410058;6273.498120150389;6276.466500347476;4740.407449068875;4753.33453316536;4754.049190161964;4762.857114286559;4763.880902977418;4733.881652958669;4743.288506724001;4772.069446457942;4774.904501909959;4779.90440191196;4636.652251081166;4713.811447542094;4727.1254817858635;4728.101660684476;4734.171519984006;4712.434507859079;4713.787879545412;4715.457722361938;4716.457607375161;4719.952800472003;4059.857904973341;4070.837166513336;4077.673786097105;4083.4079058536345;4084.9591504084874;5958.493528050121;5982.670953097578;5989.3112292086535;6001.4298641628975;6002.129691194752;5367.892642147135;5505.642133261325;5513.751881165357;5526.530244929186;5531.861703457405;6681.966590167067;6688.29772873851;6696.397324240842;6699.598024118569;6701.3968742812895;4518.5481451854885;4530.592246697813;4540.091981603692;4541.205289074399;4550.249208880531;6798.184217893835;6911.723531058751;6926.619035953021;6929.341712537301;6971.675381677465;4608.193566125915;4617.746023968714;4626.259798432302;4632.050429661911;4645.279981602857;4687.601553867959;4689.273162659793;4702.130105930414;4703.482616912137;4714;5489.533389661923;5490.69801160932;5496.065668836308;5496.422875598005;5508.807191748269;6633.803660167246;6637.369449902251;6715.160604924385;6716.664166791641;6735.057092007123;1600.4718442914043;1625.3417365966802;1626.414490783317;1632.8285530019177;1635.5175223309152;1065.7761870007384;1070.6680928912062;1074.4412905289205;1075.6772968109535;1084.3385534823751;6207.441330280297;6269.968650156811;6285.59143655661;6287.748490060438;6288.968555157195;6724.562903411263;6753;6792.762253321209;6809.319068093151;6828.112345395067;6148.292946311231;6179.104029915637;6187.876242475125;6190.102435146879;6190.7523699051535;3670.944935825965;3679.889603311905;3683.447482877536;3685.391910334765;3693.8891833245048;7117.074780278531;7119.92880071203;7126.893096603555;7127.251638577978;7142.785716428515;6767.52627316093;6909.447244220451;6980.406665433394;6980.581165130108;6994.300569943067;7084.149902011689;7090.574565526085;7111.111111111111;7122.501424900207;7131.821704457327;6782.389584937379;6782.728690852508;6786.3892249697765;6802.455803535804;6804.795856124324;6582.275949645439;6710.798676039727;6728.562643428161;6740.427063699641;6746.5277430581355;7060.046893669494;7077.929220707727;7078.787636370917;7081.752138675121;7082.822929426599;4585.151746926829;4587.908241835212;4599.747013914267;4607.884802879955;4612.561806628365;6717.361850624183;6739.19129704419;6741.426978706865;6792.422644075309;6944.236134025152;6711.228208756055;6730.831729206809;6733.124693789776;6738.66306684654;6763.425108865801;6667.833304167435;6671.8665626686225;6673;6677.3656502632175;6678.699458524281;6431.163948686828;6550.213974323112;6665.166854143232;6671.366220209073;6682.131322927989;6758.324167583202;6769.3907548320885;6784.626845523346;6785.898211526733;6793.4565234782085;6553.934460655332;6608.43828274602;6617.073609694743;6623.867522649616;6624.403803657694 20:20:44 INFO - PROCESS | 29442 | |5;yui.html;721.9350258476736;723.7394537966335;738;827.189354432656;836.3267569606467;13052.216866987987;13071.085024048309;13079.215247085182;13090.21458712478;13209.075364724473;12691.619251422471;12703.618891433272;12740.681482962907;12746.872531274685;12781.360931953412;667.87310411022;681.4888833374969;753.9472236943416;764.8164440534259;771.3559178086276;800.0998876264202;807.6244546285976;811.8295158016823;817.4604760857835;818.1327792539927;867.4231635962078;874.0254616103031;874.6545114679698;875.0986483921571;877.2280393253927;852.7441767469766;854.0264098927228;855.8587833007547;857.6140736668493;860.7761981884723;629.9401556852092;635.6916895305773;636.901280301554;637.5473413876153;641.1888960465016;13548.45806167752;13561.45754169832;13588.25264610446;13602.591922242249;13633.863661363359;12966.351682415936;13027.739445211042;13204.207747535178;13294.534691285759;13413.932930335384;10195.694129176136;10340.37957722539;10483.161347092215;10510.579576816917;10522;3613.313470440608;3657.8536858525895;3664.193877347006;3781.243751249761;3782.867599634;46759.29861052087;46877.29684054742;46932.53067469316;47290.527094728954;48397;10137.391756494486;10140.898591013995;10159.796804063877;10220.233482488844;10428.634997775041;18512.537186570444;18564.164612592467;18613.90693046553;18625.7206141908;18716.625667486845;7602.353799927068;7603.46775725705;7828.960855195687;7886.566238856918;8020.318272946748;4177.039280965395;4183.97908010458;4215.093754842724;4305.784710764449;4350.956490435118;3120.516319970363;3125.4842950912844;3141.9057428277188;3163.8259895705955;3169.0968074098773;585.4321308330913;591.5977135547869;601.2334273800851;607.4563265877104;613.4969325153331;533.4798571392861;547.258464780225;597.2683462758087;648.3415324616166;660.323168752033;8360.958195209107;8598.656053757904;8878.334124940655;8922.107789221025;9090.727278181665;521.9660722053054;526.3578434310135;536.6672662948996;572.699332850257;665.3379887012453;3850.8267127979307;4078.1232035112;4117.855875044419;4137.50349958007;4183.644390226865;56687;56950.715246423504;60294.69852650708;60860.69569652124;61066.38933610607;49583.504164957885;50045.49954500408;51288.487115129115;51489.742551287;51954.74022629863;46586.06827863424;47307;47364;48038.759806200746;48115;8868.512231827053;9200.585973631336;9218.539073046186;9270.119338663086;9282.35023548345;33785.15537111592;34544.30911381808;34736.478952815225;34836.65163348334;34936;40484;40844;40981.79509102435;40986;41131.383029253986;11205.887941120485;11348.489317980546;11492.712682183012;11582.07343412508;11585.198902811066;12616.432260548114;12733.363331833556;12776.74446511046;13390.598282051555;13524.93237533806;10859.891401085888;10913.56345746193;11203.831942521032;11213.215074945001;11443.427828608703;11593.710157246136;11895.524179032742;11951.402429878644;12311.138220324492;12388;11622.360770157722;11694.590689325832;12126.333051682243;12233;12364.319962401794;9416.458754108673;9547.618095276111;9631.614735410785;9633.32566720351;9847.753806154904;9422;10421;10519.526621302213;10562.788744225227;10613.310134841211 20:20:44 INFO - PROCESS | 29442 | __end_tp_report 20:20:44 INFO - PROCESS | 29442 | __start_cc_report 20:20:44 INFO - PROCESS | 29442 | _x_x_mozilla_cycle_collect,311 20:20:44 INFO - PROCESS | 29442 | __end_cc_report 20:20:44 INFO - PROCESS | 29442 | __startTimestamp1453090844658__endTimestamp 20:20:44 INFO - PROCESS | 29442 | 20:20:44 INFO - PROCESS | 29442 | ------- Summary: start ------- 20:20:44 INFO - PROCESS | 29442 | Number of tests: 6 20:20:44 INFO - PROCESS | 29442 | 20:20:44 INFO - PROCESS | 29442 | [#0] dojo.html Cycles:165 Average:5366.30 Median:5585.33 stddev:593.72 (10.6%) stddev-sans-first:570.79 20:20:44 INFO - PROCESS | 29442 | Values: 3203.6 3215.4 3246.9 3255.1 3266.8 5295.4 5344.7 5350.1 5351.6 5352.1 5307.2 5328.4 5406.1 5430.3 5435.8 4638.3 4904.6 5042.9 5043.7 5075.2 4846.8 4977.4 4988.8 5044.4 5072.3 4858.2 4865.9 4875.5 4894.6 4900.2 4881.5 4899.5 4899.6 4950.3 4960.8 4830.8 4886.9 4911.5 4915.6 4918.2 5216.5 5264.4 5281.0 5281.7 5299.3 5803.4 5807.5 5807.8 5808.6 5814.7 5718.6 5767.9 5835.5 5851.2 5852.7 5357.1 5383.6 5389.0 5431.5 5444.3 5826.8 5852.7 5854.7 5859.9 5869.0 5629.1 5629.7 5637.4 5654.9 5710.1 5781.6 5811.7 5819.8 5826.4 5855.2 5608.4 5740.3 5772.2 5801.6 5810.5 5661.4 5752.2 5754.9 5778.4 5816.2 4462.0 4477.8 4479.4 4499.4 4535.4 3960.2 3970.3 3975.6 4019.7 4021.0 5350.9 5418.7 5420.7 5442.1 5454.2 5717.3 5802.8 5850.4 5861.0 5906.0 5332.4 5345.7 5355.0 5387.8 5400.9 4784.1 4890.2 4896.5 4900.3 4946.0 5915.4 5938.9 5975.5 6022.3 6038.2 5806.8 5829.3 5834.3 5837.3 5855.2 5879.7 5964.9 6049.7 6049.8 6053.3 5662.5 5685.7 5744.2 5762.5 5784.6 5773.8 5774.8 5784.6 5790.3 5799.5 5560.6 5604.8 5642.8 5645.5 5664.3 5629.7 5692.4 5696.4 5701.2 5738.2 5528.4 5547.3 5577.4 5591.7 5599.1 5598.2 5648.2 5656.7 5659.9 5696.0 5547.6 5556.1 5558.4 5585.3 5631.2 20:20:44 INFO - PROCESS | 29442 | 20:20:44 INFO - PROCESS | 29442 | [#1] ext.html Cycles:180 Average:43486.30 Median:35840.14 stddev:69027.87 (192.6%) stddev-sans-first:69146.16 20:20:44 INFO - PROCESS | 29442 | Values: 530.2 546.4 567.2 567.2 571.1 35619.6 36539.8 36543.3 36615.8 36767.6 40680.4 41043.8 41075.8 41226.4 41363.8 8426.5 8612.6 8624.7 8629.8 8630.8 8373.8 8391.2 8405.9 8606.0 8656.2 8666.3 8715.9 8746.9 8753.2 8757.8 8581.9 8656.6 8658.1 8672.4 8710.3 8495.6 8569.8 8657.3 8672.8 8680.9 39026.4 39293.4 39542.4 39555.8 39566.6 2973.3 3124.6 3140.7 3303.0 3357.8 29085.3 29219.0 29600.7 29880.0 30355.5 3726.5 3817.3 3839.2 3855.2 3900.9 264422.0 264520.0 265061.0 265629.0 265881.0 53709.7 55216.0 59292.4 59545.4 60812.7 56142.0 56351.7 56603.7 56604.4 56712.7 15379.6 15421.0 15472.4 15568.0 15589.5 11784.3 11910.8 11920.5 11943.9 11946.4 19758.9 20040.1 20807.9 20809.3 20986.5 7198.3 7377.2 7405.9 7440.9 7464.2 878.3 922.1 942.4 944.0 957.5 29191.0 29233.3 29433.6 29583.6 29727.3 1007.1 1045.9 1073.9 1079.4 1121.2 14411.6 14708.8 14826.0 14885.8 14885.9 307892.0 312837.0 312896.0 313132.0 313402.0 52935.2 52957.7 52977.0 53134.0 53292.7 1337.8 1344.1 1346.4 1347.4 1360.2 27961.0 28120.6 28656.6 28692.4 29092.0 47318.8 47336.0 47593.5 47834.0 48046.0 203849.0 205695.0 206361.0 206483.0 207385.0 31017.0 32629.0 33119.8 33129.7 33161.7 38999.0 43711.8 44759.0 45590.8 46673.5 34296.6 34750.0 34950.0 34985.3 36060.6 34991.5 34993.7 35273.0 35489.3 35550.0 35322.8 36545.3 37380.3 37433.3 37450.6 28333.0 30778.8 30866.4 31297.7 31366.0 23569.6 24043.8 25340.5 25365.7 26330.7 20:20:44 INFO - PROCESS | 29442 | 20:20:44 INFO - PROCESS | 29442 | [#2] jquery.html Cycles:180 Average:27619.20 Median:268647.56 stddev:89315.17 (33.2%) stddev-sans-first:89542.25 20:20:44 INFO - PROCESS | 29442 | Values: 352.7 356.9 357.7 358.0 359.6 15674.4 16162.6 16917.7 17182.9 17626.8 11052.6 11513.8 16758.6 16790.2 16826.7 4592.7 5284.2 5299.7 5314.1 5322.1 4709.0 5015.3 5190.6 5282.9 5289.8 5346.6 5357.5 5404.7 5646.2 5676.6 5545.5 5685.3 5730.2 5960.5 5966.0 5294.9 5308.7 5313.9 5322.1 5336.7 16895.5 19278.3 19921.4 20170.4 20387.9 1920.5 1965.9 2088.5 2102.5 2244.8 9452.1 9496.2 9541.2 9582.8 9672.2 1797.4 1813.7 1824.3 1824.8 1890.7 55478.0 57952.4 57956.4 58359.8 58591.4 9729.5 9851.8 9883.7 9929.9 10027.0 12467.5 12563.3 12563.9 12571.6 12584.9 7338.5 7344.9 7365.4 7373.3 7411.9 7054.7 7077.5 7101.5 7103.1 7128.1 4384.0 4386.5 4425.5 4437.9 4496.7 1701.3 1770.6 1771.7 1831.8 1869.1 919.4 944.7 970.5 985.5 999.0 14419.2 15253.8 15278.5 15729.8 15784.2 907.8 914.6 960.8 975.5 977.8 9028.6 9128.4 9250.9 9335.0 9712.9 531973.0 538906.0 547523.0 554247.0 560355.0 71138.0 71212.6 71959.3 72105.3 73160.3 1150.9 1181.0 1189.8 1190.3 1192.5 14776.3 14946.4 15007.3 15334.5 15651.6 32817.8 33363.7 33582.3 34068.3 34794.8 42949.1 43079.0 43164.6 43921.3 44035.8 7060.5 7266.1 7372.0 7469.3 7516.8 9423.1 10490.6 11010.4 11128.9 11390.7 8894.9 9036.8 9602.0 9602.1 9637.4 9456.2 9552.8 9617.4 9985.6 10123.1 9250.1 9331.3 9494.3 9522.6 9605.7 7327.3 7501.2 7538.4 7591.8 7631.0 8627.9 9741.2 9873.4 10023.8 10061.7 20:20:44 INFO - PROCESS | 29442 | 20:20:44 INFO - PROCESS | 29442 | [#3] mootools.html Cycles:180 Average:5348.49 Median:6175.38 stddev:2692.39 (43.6%) stddev-sans-first:2684.30 20:20:44 INFO - PROCESS | 29442 | Values: 1487.4 1509.2 1675.2 1782.2 1812.3 7372.3 7462.4 7633.4 7646.0 7682.8 7464.4 7514.2 7518.5 7593.1 7593.2 2322.3 2335.2 2344.9 2346.7 2348.9 2317.7 2327.1 2337.0 2359.4 2368.9 2245.8 2313.4 2317.0 2322.0 2337.1 2294.9 2332.3 2367.2 2368.1 2375.2 2377.3 2388.1 2391.1 2397.4 2400.0 7293.1 7353.5 7377.9 7382.2 7399.4 4681.5 4725.4 4749.7 4763.6 4789.0 3109.5 3157.6 3201.4 3203.4 3211.6 1000.2 1008.7 1013.7 1022.4 1048.5 10348.9 10387.4 10467.4 10471.6 10485.3 4184.2 4260.6 4317.6 4325.0 4353.7 8459.1 8462.5 8464.2 8474.7 8484.4 4662.1 4688.4 4693.8 4709.7 4725.4 4308.2 4312.4 4335.7 4362.4 4370.9 3444.5 3450.8 3452.5 3480.6 3488.4 1068.7 1078.2 1099.8 1101.2 1127.0 1311.6 1315.6 1315.8 1327.0 1346.1 7047.4 7146.1 7174.8 7176.2 7188.1 1126.1 1133.8 1140.5 1141.9 1147.1 5583.7 5722.9 5794.1 5814.9 5818.8 8933.2 9113.9 9403.6 9449.6 9491.0 9154.5 9247.4 9255.7 9268.8 9302.1 7047.6 7172.4 7173.6 7187.2 7192.3 6908.4 6930.8 6951.6 6978.3 6983.4 8035.0 8049.1 8178.8 8200.2 8298.5 8235.0 8366.3 8408.4 8413.2 8423.0 6337.7 6409.9 6577.3 6579.4 6589.2 7233.6 7236.3 7250.9 7263.5 7311.6 6666.5 6787.8 6815.2 6975.9 7059.6 6473.8 6480.4 6503.7 6605.3 6623.4 6787.8 6801.0 6802.6 6821.7 6822.0 6158.1 6245.7 6272.1 6312.1 6321.4 6192.7 6269.8 6270.7 6274.8 6287.3 20:20:44 INFO - PROCESS | 29442 | 20:20:44 INFO - PROCESS | 29442 | [#4] prototype.html Cycles:180 Average:5531.78 Median:6266.50 stddev:1692.72 (27.0%) stddev-sans-first:1651.79 20:20:44 INFO - PROCESS | 29442 | Values: 328.4 332.4 334.0 337.9 338.7 6219.1 6232.8 6266.1 6308.1 6445.1 6220.1 6260.2 6266.9 6273.5 6276.5 4740.4 4753.3 4754.0 4762.9 4763.9 4733.9 4743.3 4772.1 4774.9 4779.9 4636.7 4713.8 4727.1 4728.1 4734.2 4712.4 4713.8 4715.5 4716.5 4720.0 4059.9 4070.8 4077.7 4083.4 4085.0 5958.5 5982.7 5989.3 6001.4 6002.1 5367.9 5505.6 5513.8 5526.5 5531.9 6682.0 6688.3 6696.4 6699.6 6701.4 4518.5 4530.6 4540.1 4541.2 4550.2 6798.2 6911.7 6926.6 6929.3 6971.7 4608.2 4617.7 4626.3 4632.1 4645.3 4687.6 4689.3 4702.1 4703.5 4714.0 5489.5 5490.7 5496.1 5496.4 5508.8 6633.8 6637.4 6715.2 6716.7 6735.1 1600.5 1625.3 1626.4 1632.8 1635.5 1065.8 1070.7 1074.4 1075.7 1084.3 6207.4 6270.0 6285.6 6287.7 6289.0 6724.6 6753.0 6792.8 6809.3 6828.1 6148.3 6179.1 6187.9 6190.1 6190.8 3670.9 3679.9 3683.4 3685.4 3693.9 7117.1 7119.9 7126.9 7127.3 7142.8 6767.5 6909.4 6980.4 6980.6 6994.3 7084.1 7090.6 7111.1 7122.5 7131.8 6782.4 6782.7 6786.4 6802.5 6804.8 6582.3 6710.8 6728.6 6740.4 6746.5 7060.0 7077.9 7078.8 7081.8 7082.8 4585.2 4587.9 4599.7 4607.9 4612.6 6717.4 6739.2 6741.4 6792.4 6944.2 6711.2 6730.8 6733.1 6738.7 6763.4 6667.8 6671.9 6673.0 6677.4 6678.7 6431.2 6550.2 6665.2 6671.4 6682.1 6758.3 6769.4 6784.6 6785.9 6793.5 6553.9 6608.4 6617.1 6623.9 6624.4 20:20:44 INFO - PROCESS | 29442 | 20:20:44 INFO - PROCESS | 29442 | [#5] yui.html Cycles:180 Average:13859.19 Median:4199.54 stddev:15839.41 (377.2%) stddev-sans-first:15853.12 20:20:44 INFO - PROCESS | 29442 | Values: 721.9 723.7 738.0 827.2 836.3 13052.2 13071.1 13079.2 13090.2 13209.1 12691.6 12703.6 12740.7 12746.9 12781.4 667.9 681.5 753.9 764.8 771.4 800.1 807.6 811.8 817.5 818.1 867.4 874.0 874.7 875.1 877.2 852.7 854.0 855.9 857.6 860.8 629.9 635.7 636.9 637.5 641.2 13548.5 13561.5 13588.3 13602.6 13633.9 12966.4 13027.7 13204.2 13294.5 13413.9 10195.7 10340.4 10483.2 10510.6 10522.0 3613.3 3657.9 3664.2 3781.2 3782.9 46759.3 46877.3 46932.5 47290.5 48397.0 10137.4 10140.9 10159.8 10220.2 10428.6 18512.5 18564.2 18613.9 18625.7 18716.6 7602.4 7603.5 7829.0 7886.6 8020.3 4177.0 4184.0 4215.1 4305.8 4351.0 3120.5 3125.5 3141.9 3163.8 3169.1 585.4 591.6 601.2 607.5 613.5 533.5 547.3 597.3 648.3 660.3 8361.0 8598.7 8878.3 8922.1 9090.7 522.0 526.4 536.7 572.7 665.3 3850.8 4078.1 4117.9 4137.5 4183.6 56687.0 56950.7 60294.7 60860.7 61066.4 49583.5 50045.5 51288.5 51489.7 51954.7 46586.1 47307.0 47364.0 48038.8 48115.0 8868.5 9200.6 9218.5 9270.1 9282.4 33785.2 34544.3 34736.5 34836.7 34936.0 40484.0 40844.0 40981.8 40986.0 41131.4 11205.9 11348.5 11492.7 11582.1 11585.2 12616.4 12733.4 12776.7 13390.6 13524.9 10859.9 10913.6 11203.8 11213.2 11443.4 11593.7 11895.5 11951.4 12311.1 12388.0 11622.4 11694.6 12126.3 12233.0 12364.3 9416.5 9547.6 9631.6 9633.3 9847.8 9422.0 10421.0 10519.5 10562.8 10613.3 20:20:44 INFO - PROCESS | 29442 | -------- Summary: end -------- 20:20:44 INFO - PROCESS | 29442 | 20:20:45 INFO - TEST-INFO | 29442: exit 0 20:20:45 INFO - TEST-OK | dromaeo_css | took 1110945ms 20:20:45 INFO - TEST-START | kraken 20:20:45 INFO - operating with platform_type : linux_ 20:20:45 INFO - Initialising browser for kraken test... 20:20:45 INFO - TEST-INFO | started process 29685 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpp7KXmn/profile http://localhost:60327/getInfo.html) 20:20:48 INFO - PROCESS | 29685 | 20:20:48 INFO - PROCESS | 29685 | (process:29756): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:20:49 INFO - PROCESS | 29685 | __metrics Screen width/height:1600/1200 20:20:49 INFO - PROCESS | 29685 | colorDepth:24 20:20:49 INFO - PROCESS | 29685 | Browser inner width/height: 1024/697 20:20:49 INFO - PROCESS | 29685 | __metrics 20:20:49 INFO - PROCESS | 29685 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:20:50 INFO - TEST-INFO | 29685: exit 0 20:20:50 INFO - Browser initialized. 20:20:50 INFO - Running cycle 1/1 for kraken test... 20:20:50 INFO - TEST-INFO | started process 29806 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpp7KXmn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:20:51 INFO - PROCESS | 29806 | -- checkerboarding starts below -- 20:20:51 INFO - PROCESS | 29806 | RENDERTRACE 0.03175 rect red 0 0 10 10 // viewport 20:20:51 INFO - PROCESS | 29806 | RENDERTRACE 47.1926 rect brown 0 0 10 10 // page 20:20:51 INFO - PROCESS | 29806 | RENDERTRACE 47.2105 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 20:20:51 INFO - PROCESS | 29806 | Checkerboarded for 1 frames (50.3042 ms), 100 peak, 1 severity. 20:20:52 INFO - PROCESS | 29806 | 20:20:52 INFO - PROCESS | 29806 | (process:29868): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:21:02 INFO - PROCESS | 29806 | RSS: Main: 149626880 20:21:02 INFO - PROCESS | 29806 | 20:21:04 INFO - PROCESS | 29806 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60327/tests/kraken/driver.html?testName=audio-beat-detection) 20:21:05 INFO - PROCESS | 29806 | RSS: Main: 150605824 20:21:05 INFO - PROCESS | 29806 | 20:21:08 INFO - PROCESS | 29806 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60327/tests/kraken/driver.html?testName=audio-dft) 20:21:08 INFO - PROCESS | 29806 | RSS: Main: 154996736 20:21:08 INFO - PROCESS | 29806 | 20:21:11 INFO - PROCESS | 29806 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60327/tests/kraken/driver.html?testName=audio-fft) 20:21:12 INFO - PROCESS | 29806 | RSS: Main: 147177472 20:21:12 INFO - PROCESS | 29806 | 20:21:14 INFO - PROCESS | 29806 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60327/tests/kraken/driver.html?testName=audio-oscillator) 20:21:14 INFO - PROCESS | 29806 | RSS: Main: 148418560 20:21:14 INFO - PROCESS | 29806 | 20:21:17 INFO - PROCESS | 29806 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60327/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:21:17 INFO - PROCESS | 29806 | RSS: Main: 148844544 20:21:17 INFO - PROCESS | 29806 | 20:21:20 INFO - PROCESS | 29806 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60327/tests/kraken/driver.html?testName=imaging-darkroom) 20:21:21 INFO - PROCESS | 29806 | RSS: Main: 149307392 20:21:21 INFO - PROCESS | 29806 | 20:21:24 INFO - PROCESS | 29806 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60327/tests/kraken/driver.html?testName=imaging-desaturate) 20:21:25 INFO - PROCESS | 29806 | RSS: Main: 149372928 20:21:25 INFO - PROCESS | 29806 | 20:21:27 INFO - PROCESS | 29806 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60327/tests/kraken/driver.html?testName=json-parse-financial) 20:21:28 INFO - PROCESS | 29806 | RSS: Main: 149753856 20:21:28 INFO - PROCESS | 29806 | 20:21:30 INFO - PROCESS | 29806 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60327/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:21:30 INFO - PROCESS | 29806 | RSS: Main: 150102016 20:21:30 INFO - PROCESS | 29806 | 20:21:32 INFO - PROCESS | 29806 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60327/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:21:33 INFO - PROCESS | 29806 | RSS: Main: 149811200 20:21:33 INFO - PROCESS | 29806 | 20:21:35 INFO - PROCESS | 29806 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60327/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:21:35 INFO - PROCESS | 29806 | RSS: Main: 150355968 20:21:35 INFO - PROCESS | 29806 | 20:21:38 INFO - PROCESS | 29806 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60327/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:21:38 INFO - PROCESS | 29806 | RSS: Main: 150786048 20:21:38 INFO - PROCESS | 29806 | 20:21:41 INFO - PROCESS | 29806 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60327/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:21:41 INFO - PROCESS | 29806 | RSS: Main: 149884928 20:21:41 INFO - PROCESS | 29806 | 20:21:43 INFO - PROCESS | 29806 | Cycle 1(1): loaded http://localhost:60327/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60327/tests/kraken/driver.html?testName=ai-astar) 20:21:43 INFO - PROCESS | 29806 | RSS: Main: 149970944 20:21:43 INFO - PROCESS | 29806 | 20:21:43 INFO - PROCESS | 29806 | __start_tp_report 20:21:43 INFO - PROCESS | 29806 | _x_x_mozilla_page_load 20:21:43 INFO - PROCESS | 29806 | _x_x_mozilla_page_load_details 20:21:43 INFO - PROCESS | 29806 | |i|pagename|runs| 20:21:43 INFO - PROCESS | 29806 | |0;ai-astar;110;104;110;109;110;121;111;109;110;108 20:21:43 INFO - PROCESS | 29806 | |1;audio-beat-detection;151;126;149;160;128;146;155;127;164;127 20:21:43 INFO - PROCESS | 29806 | |2;audio-dft;162;162;163;163;162;164;160;164;171;164 20:21:43 INFO - PROCESS | 29806 | |3;audio-fft;75;73;71;75;74;72;150;75;75;71 20:21:43 INFO - PROCESS | 29806 | |4;audio-oscillator;97;96;145;95;96;96;149;96;96;144 20:21:43 INFO - PROCESS | 29806 | |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;109;110 20:21:43 INFO - PROCESS | 29806 | |6;imaging-darkroom;146;146;147;147;146;146;147;147;147;147 20:21:43 INFO - PROCESS | 29806 | |7;imaging-desaturate;96;96;96;97;97;97;97;96;96;97 20:21:43 INFO - PROCESS | 29806 | |8;json-parse-financial;59;61;57;57;57;60;58;57;66;61 20:21:43 INFO - PROCESS | 29806 | |9;json-stringify-tinderbox;66;68;67;67;67;69;67;67;70;68 20:21:43 INFO - PROCESS | 29806 | |10;stanford-crypto-aes;83;82;84;84;86;85;84;84;86;84 20:21:43 INFO - PROCESS | 29806 | |11;stanford-crypto-ccm;118;117;127;122;115;119;130;123;115;122 20:21:43 INFO - PROCESS | 29806 | |12;stanford-crypto-pbkdf2;131;145;144;143;140;132;142;141;142;143 20:21:43 INFO - PROCESS | 29806 | |13;stanford-crypto-sha256-iterative;67;67;67;66;68;67;65;67;66;67 20:21:43 INFO - PROCESS | 29806 | __end_tp_report 20:21:43 INFO - PROCESS | 29806 | __start_cc_report 20:21:43 INFO - PROCESS | 29806 | _x_x_mozilla_cycle_collect,725 20:21:43 INFO - PROCESS | 29806 | __end_cc_report 20:21:43 INFO - PROCESS | 29806 | __startTimestamp1453090903835__endTimestamp 20:21:43 INFO - PROCESS | 29806 | 20:21:43 INFO - PROCESS | 29806 | ------- Summary: start ------- 20:21:43 INFO - PROCESS | 29806 | Number of tests: 14 20:21:43 INFO - PROCESS | 29806 | 20:21:43 INFO - PROCESS | 29806 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.00 stddev:4.26 (3.9%) stddev-sans-first:4.52 20:21:43 INFO - PROCESS | 29806 | Values: 110.0 104.0 110.0 109.0 110.0 121.0 111.0 109.0 110.0 108.0 20:21:43 INFO - PROCESS | 29806 | 20:21:43 INFO - PROCESS | 29806 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:150.00 stddev:14.94 (10.0%) stddev-sans-first:15.58 20:21:43 INFO - PROCESS | 29806 | Values: 151.0 126.0 149.0 160.0 128.0 146.0 155.0 127.0 164.0 127.0 20:21:43 INFO - PROCESS | 29806 | 20:21:43 INFO - PROCESS | 29806 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.50 stddev:2.92 (1.8%) stddev-sans-first:3.04 20:21:43 INFO - PROCESS | 29806 | Values: 162.0 162.0 163.0 163.0 162.0 164.0 160.0 164.0 171.0 164.0 20:21:43 INFO - PROCESS | 29806 | 20:21:43 INFO - PROCESS | 29806 | [#3] audio-fft Cycles:10 Average:81.10 Median:74.50 stddev:24.26 (32.6%) stddev-sans-first:25.64 20:21:43 INFO - PROCESS | 29806 | Values: 75.0 73.0 71.0 75.0 74.0 72.0 150.0 75.0 75.0 71.0 20:21:43 INFO - PROCESS | 29806 | 20:21:43 INFO - PROCESS | 29806 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:96.00 stddev:24.19 (25.2%) stddev-sans-first:25.12 20:21:43 INFO - PROCESS | 29806 | Values: 97.0 96.0 145.0 95.0 96.0 96.0 149.0 96.0 96.0 144.0 20:21:43 INFO - PROCESS | 29806 | 20:21:43 INFO - PROCESS | 29806 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 20:21:43 INFO - PROCESS | 29806 | Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 20:21:43 INFO - PROCESS | 29806 | 20:21:43 INFO - PROCESS | 29806 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 20:21:43 INFO - PROCESS | 29806 | Values: 146.0 146.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 20:21:43 INFO - PROCESS | 29806 | 20:21:43 INFO - PROCESS | 29806 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 20:21:43 INFO - PROCESS | 29806 | Values: 96.0 96.0 96.0 97.0 97.0 97.0 97.0 96.0 96.0 97.0 20:21:43 INFO - PROCESS | 29806 | 20:21:43 INFO - PROCESS | 29806 | [#8] json-parse-financial Cycles:10 Average:59.30 Median:59.50 stddev:2.87 (4.8%) stddev-sans-first:3.04 20:21:43 INFO - PROCESS | 29806 | Values: 59.0 61.0 57.0 57.0 57.0 60.0 58.0 57.0 66.0 61.0 20:21:43 INFO - PROCESS | 29806 | 20:21:43 INFO - PROCESS | 29806 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:67.50 stddev:1.17 (1.7%) stddev-sans-first:1.09 20:21:43 INFO - PROCESS | 29806 | Values: 66.0 68.0 67.0 67.0 67.0 69.0 67.0 67.0 70.0 68.0 20:21:43 INFO - PROCESS | 29806 | 20:21:43 INFO - PROCESS | 29806 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:1.23 (1.5%) stddev-sans-first:1.22 20:21:43 INFO - PROCESS | 29806 | Values: 83.0 82.0 84.0 84.0 86.0 85.0 84.0 84.0 86.0 84.0 20:21:43 INFO - PROCESS | 29806 | 20:21:43 INFO - PROCESS | 29806 | [#11] stanford-crypto-ccm Cycles:10 Average:120.80 Median:122.00 stddev:4.98 (4.1%) stddev-sans-first:5.18 20:21:43 INFO - PROCESS | 29806 | Values: 118.0 117.0 127.0 122.0 115.0 119.0 130.0 123.0 115.0 122.0 20:21:43 INFO - PROCESS | 29806 | 20:21:43 INFO - PROCESS | 29806 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.30 Median:142.50 stddev:4.85 (3.4%) stddev-sans-first:3.81 20:21:43 INFO - PROCESS | 29806 | Values: 131.0 145.0 144.0 143.0 140.0 132.0 142.0 141.0 142.0 143.0 20:21:43 INFO - PROCESS | 29806 | 20:21:43 INFO - PROCESS | 29806 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 20:21:43 INFO - PROCESS | 29806 | Values: 67.0 67.0 67.0 66.0 68.0 67.0 65.0 67.0 66.0 67.0 20:21:43 INFO - PROCESS | 29806 | -------- Summary: end -------- 20:21:43 INFO - PROCESS | 29806 | 20:21:44 INFO - TEST-INFO | 29806: exit 0 20:21:44 INFO - TEST-OK | kraken | took 59399ms 20:21:44 INFO - TEST-START | v8_7 20:21:44 INFO - operating with platform_type : linux_ 20:21:44 INFO - Initialising browser for v8_7 test... 20:21:44 INFO - TEST-INFO | started process 30096 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBG1ZTy/profile http://localhost:60327/getInfo.html) 20:21:48 INFO - PROCESS | 30096 | 20:21:48 INFO - PROCESS | 30096 | (process:30169): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:21:49 INFO - PROCESS | 30096 | __metrics Screen width/height:1600/1200 20:21:49 INFO - PROCESS | 30096 | colorDepth:24 20:21:49 INFO - PROCESS | 30096 | Browser inner width/height: 1024/697 20:21:49 INFO - PROCESS | 30096 | __metrics 20:21:49 INFO - PROCESS | 30096 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:21:50 INFO - TEST-INFO | 30096: exit 0 20:21:50 INFO - Browser initialized. 20:21:50 INFO - Running cycle 1/1 for v8_7 test... 20:21:50 INFO - TEST-INFO | started process 30218 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpBG1ZTy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:50 INFO - PROCESS | 30218 | -- checkerboarding starts below -- 20:21:50 INFO - PROCESS | 30218 | RENDERTRACE 0.032767 rect red 0 0 10 10 // viewport 20:21:50 INFO - PROCESS | 30218 | RENDERTRACE 102.04 rect brown 0 0 10 10 // page 20:21:50 INFO - PROCESS | 30218 | RENDERTRACE 102.081 rect lightgreen 0 0 10 10 // painted displayport (this layertree updated) 20:21:50 INFO - PROCESS | 30218 | Checkerboarded for 1 frames (113.5 ms), 100 peak, 1 severity. 20:21:51 INFO - PROCESS | 30218 | 20:21:51 INFO - PROCESS | 30218 | (process:30281): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 20:22:01 INFO - PROCESS | 30218 | RSS: Main: 150151168 20:22:01 INFO - PROCESS | 30218 | 20:22:24 INFO - PROCESS | 30218 | Cycle 1(1): loaded http://localhost:60327/tests/v8_7/run.html (next: http://localhost:60327/tests/v8_7/run.html) 20:22:24 INFO - PROCESS | 30218 | RSS: Main: 145526784 20:22:24 INFO - PROCESS | 30218 | 20:22:24 INFO - PROCESS | 30218 | __start_tp_report 20:22:24 INFO - PROCESS | 30218 | _x_x_mozilla_page_load 20:22:24 INFO - PROCESS | 30218 | _x_x_mozilla_page_load_details 20:22:24 INFO - PROCESS | 30218 | |i|pagename|runs| 20:22:24 INFO - PROCESS | 30218 | |0;Richards;166.9727834362999 20:22:24 INFO - PROCESS | 30218 | |1;DeltaBlue;187.68768768768768 20:22:24 INFO - PROCESS | 30218 | |2;Encrypt;278.6291446085261 20:22:24 INFO - PROCESS | 30218 | |3;Decrypt;5208.333333333333 20:22:24 INFO - PROCESS | 30218 | |4;RayTrace;1055.9662090813094 20:22:24 INFO - PROCESS | 30218 | |5;Earley;702.7406886858749 20:22:24 INFO - PROCESS | 30218 | |6;Boyer;12329.268292682927 20:22:24 INFO - PROCESS | 30218 | |7;RegExp;41530.61224489796 20:22:24 INFO - PROCESS | 30218 | |8;Splay;592.0663114268798 20:22:24 INFO - PROCESS | 30218 | |9;NavierStokes;4826.923076923077 20:22:24 INFO - PROCESS | 30218 | __end_tp_report 20:22:24 INFO - PROCESS | 30218 | __startTimestamp1453090944580__endTimestamp 20:22:24 INFO - PROCESS | 30218 | 20:22:24 INFO - PROCESS | 30218 | ------- Summary: start ------- 20:22:24 INFO - PROCESS | 30218 | Number of tests: 10 20:22:24 INFO - PROCESS | 30218 | 20:22:24 INFO - PROCESS | 30218 | [#0] Richards Cycles:1 Average:166.97 Median:166.97 stddev:0.00 (0.0%) 20:22:24 INFO - PROCESS | 30218 | Values: 167.0 20:22:24 INFO - PROCESS | 30218 | 20:22:24 INFO - PROCESS | 30218 | [#1] DeltaBlue Cycles:1 Average:187.69 Median:187.69 stddev:0.00 (0.0%) 20:22:24 INFO - PROCESS | 30218 | Values: 187.7 20:22:24 INFO - PROCESS | 30218 | 20:22:24 INFO - PROCESS | 30218 | [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 20:22:24 INFO - PROCESS | 30218 | Values: 278.6 20:22:24 INFO - PROCESS | 30218 | 20:22:24 INFO - PROCESS | 30218 | [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 20:22:24 INFO - PROCESS | 30218 | Values: 5208.3 20:22:24 INFO - PROCESS | 30218 | 20:22:24 INFO - PROCESS | 30218 | [#4] RayTrace Cycles:1 Average:1055.97 Median:1055.97 stddev:0.00 (0.0%) 20:22:24 INFO - PROCESS | 30218 | Values: 1056.0 20:22:24 INFO - PROCESS | 30218 | 20:22:24 INFO - PROCESS | 30218 | [#5] Earley Cycles:1 Average:702.74 Median:702.74 stddev:0.00 (0.0%) 20:22:24 INFO - PROCESS | 30218 | Values: 702.7 20:22:24 INFO - PROCESS | 30218 | 20:22:24 INFO - PROCESS | 30218 | [#6] Boyer Cycles:1 Average:12329.27 Median:12329.27 stddev:0.00 (0.0%) 20:22:24 INFO - PROCESS | 30218 | Values: 12329.3 20:22:24 INFO - PROCESS | 30218 | 20:22:24 INFO - PROCESS | 30218 | [#7] RegExp Cycles:1 Average:41530.61 Median:41530.61 stddev:0.00 (0.0%) 20:22:24 INFO - PROCESS | 30218 | Values: 41530.6 20:22:24 INFO - PROCESS | 30218 | 20:22:24 INFO - PROCESS | 30218 | [#8] Splay Cycles:1 Average:592.07 Median:592.07 stddev:0.00 (0.0%) 20:22:24 INFO - PROCESS | 30218 | Values: 592.1 20:22:24 INFO - PROCESS | 30218 | 20:22:24 INFO - PROCESS | 30218 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 20:22:24 INFO - PROCESS | 30218 | Values: 4826.9 20:22:24 INFO - PROCESS | 30218 | -------- Summary: end -------- 20:22:24 INFO - PROCESS | 30218 | 20:22:25 INFO - TEST-INFO | 30218: exit 0 20:22:25 INFO - TEST-OK | v8_7 | took 40773ms 20:22:25 INFO - SUITE-END | took 1211s 20:22:25 INFO - Completed test suite (00:20:11) 20:22:25 INFO - Working with test: dromaeo_css 20:22:25 INFO - Generating results file: dromaeo_css 20:22:25 INFO - Working with test: kraken 20:22:25 INFO - Generating results file: kraken 20:22:25 INFO - javascript benchmark 20:22:25 INFO - Working with test: v8_7 20:22:25 INFO - Generating results file: v8_7 20:22:25 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:22:25 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 20:22:25 INFO - process_Request line: dromaeo_css 6917.47 graph.html#tests=[[72,64,43]] 20:22:25 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:22:25 INFO - process_Request line: kraken 1501.00 graph.html#tests=[[232,64,43]] 20:22:25 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:22:25 INFO - process_Request line: v8_7 20453.28 graph.html#tests=[[230,64,43]] 20:22:25 INFO - RETURN: dromaeo_css: 6917.47 20:22:25 INFO - RETURN: kraken: 1501.00 20:22:25 INFO - RETURN: v8_7: 20453.28 20:22:25 INFO - javascript benchmark 20:22:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3203.599550056243, 3215.4212241796467, 3246.8701251949924, 3255.1048461673045, 3266.820324882132, 5295.443978382272, 5344.652597581155, 5350.063738845701, 5351.625386222966, 5352.06338890694, 5307.203919412081, 5328.440513746049, 5406.107992181285, 5430.294061771974, 5435.83692489226, 4638.281066434708, 4904.5831104356175, 5042.899142017158, 5043.722595257259, 5075.238714192882, 4846.830360937368, 4977.402711674604, 4988.75056247188, 5044.394672639289, 5072.289879416866, 4858.246971719389, 4865.8783530411665, 4875.536824001714, 4894.583960363373, 4900.166971614834, 4881.4630390657, 4899.485554016848, 4899.583535399495, 4950.331705219821, 4960.776765045545, 4830.806767729287, 4886.853394398174, 4911.459739428696, 4915.631327650441, 4918.188498897677, 5216.530512253916, 5264.447233040552, 5281.0, 5281.683099014033, 5299.33758280215, 5803.390643982363, 5807.506361959238, 5807.796727114531, 5808.564357673149, 5814.738336774855, 5718.628289161191, 5767.855803604902, 5835.4748072673665, 5851.239338885917, 5852.67810270435, 5357.062514060024, 5383.623146379794, 5388.973055134738, 5431.456854314576, 5444.346678398578, 5826.766929322865, 5852.736626851802, 5854.736536855852, 5859.882802343929, 5869.0, 5629.0712032514175, 5629.662220266797, 5637.43625637433, 5654.85862853432, 5710.086386178192, 5781.566382521328, 5811.709414529257, 5819.767209311664, 5826.446487583673, 5855.180274761537, 5608.383077861432, 5740.253767010262, 5772.249607550992, 5801.622894511843, 5810.5351571875, 5661.405552417019, 5752.194692743019, 5754.942450575524, 5778.422157784188, 5816.185733997244, 4462.0, 4477.820887164542, 4479.395281636937, 4499.4150760400935, 4535.365048893158, 3960.20795840833, 3970.285348637273, 3975.6223158799867, 4019.698522610816, 4021.0148513613767, 5350.946490535122, 5418.701971391532, 5420.674759514362, 5442.074847275972, 5454.209139674725, 5717.256756621613, 5802.82591522255, 5850.3564607893095, 5861.032929566573, 5905.970470147622, 5332.360116786011, 5345.679259244458, 5355.0, 5387.784488620489, 5400.91898621521, 4784.138855006132, 4890.168671325883, 4896.510348965075, 4900.313956046157, 4945.9752701236985, 5915.40845915405, 5938.8812223755285, 5975.492083172892, 6022.307434644984, 6038.184845045863, 5806.76772929095, 5829.271341082364, 5834.299884013945, 5837.270341207349, 5855.2095467113095, 5879.7060146993335, 5964.940350596438, 6049.667268300285, 6049.818505444844, 6053.303870055, 5662.462066103713, 5685.687287199244, 5744.195812586157, 5762.510186634183, 5784.595078344475, 5773.797917072882, 5774.797882074107, 5784.595078344475, 5790.334111577223, 5799.5070419014855, 5560.638558493685, 5604.8318550443555, 5642.830715078554, 5645.520130788929, 5664.320281566238, 5629.6903670298525, 5692.402297758676, 5696.430356964271, 5701.230333905036, 5738.196652468741, 5528.391876893458, 5547.278853749148, 5577.414371491097, 5591.664500130005, 5599.076152434803, 5598.188262701967, 5648.209250704823, 5656.717164141859, 5659.943400565941, 5695.971520142372, 5547.639403438763, 5556.083246264321, 5558.3607885092115, 5585.329760428612, 5631.211630371669], "unit": "score", "name": "dojo.html", "value": 5327.992836405469}, {"lowerIsBetter": false, "replicates": [530.1517571884984, 546.3662151903791, 567.1634339349458, 567.1917517537513, 571.140433647361, 35619.64380356196, 36539.817300913455, 36543.269134617294, 36615.81692091536, 36767.63232367676, 40680.38979415311, 41043.794781026125, 41075.79462102686, 41226.381604275884, 41363.793181034125, 8426.536540490271, 8612.612432440555, 8624.741257762276, 8629.784255393603, 8630.784230394227, 8373.790655233606, 8391.202835730595, 8405.915940840605, 8605.95697021514, 8656.220940115389, 8666.30669546438, 8715.912840871573, 8746.86879696802, 8753.212210901018, 8757.824843503126, 8581.871271930895, 8656.567171641424, 8658.090900455456, 8672.392932494728, 8710.259627931633, 8495.617697203641, 8569.785755356166, 8657.307415406753, 8672.826543469158, 8680.8697869532, 39026.41460378097, 39293.41059884104, 39542.406863897064, 39555.80222098871, 39566.604333956864, 2973.2715484706387, 3124.6406663233793, 3140.685931406864, 3303.0256074458093, 3357.7649564530493, 29085.272868178254, 29219.0, 29600.703992960225, 29880.0, 30355.544666830014, 3726.496922915399, 3817.274717803636, 3839.167849450618, 3855.1711382052995, 3900.921981560353, 264422.0, 264520.0, 265061.0, 265629.0, 265881.0, 53709.73145134249, 55216.0, 59292.40707592869, 59545.40454595485, 60812.69593652003, 56142.0, 56351.71824140853, 56603.71698141565, 56604.43395566074, 56712.71643641838, 15379.615509612126, 15420.997635153679, 15472.381104755908, 15567.988080774714, 15589.454369097253, 11784.292942423483, 11910.761784764256, 11920.46357913896, 11943.940280298542, 11946.402679866145, 19758.90120549388, 20040.098195581235, 20807.8959605201, 20809.27167549159, 20986.47533811667, 7198.316159964795, 7377.151627562792, 7405.8889116663295, 7440.925590744131, 7464.216257292906, 878.3105262369137, 922.114769820966, 942.4486675294892, 943.9575219115156, 957.5355952363099, 29191.0, 29233.32266837296, 29433.55849662257, 29583.556246656317, 29727.25681857971, 1007.0684616729496, 1045.8640376751125, 1073.9140868730483, 1079.384750692098, 1121.198343184627, 14411.567652970427, 14708.779368309484, 14826.0, 14885.80973766347, 14885.92557037208, 307892.0, 312837.0, 312896.0, 313132.0, 313402.0, 52935.20597191045, 52957.7352113237, 52977.0, 53134.0, 53292.733536332846, 1337.8461476930277, 1344.1061693973593, 1346.4344975110478, 1347.3869389427787, 1360.2314692198877, 27961.0, 28120.578191327557, 28656.57015144733, 28692.42615147727, 29092.0, 47318.76340618275, 47336.0, 47593.52406475891, 47834.0, 48046.0, 203849.0, 205695.0, 206361.0, 206483.0, 207385.0, 31017.0, 32629.0, 33119.83440082784, 33129.668703313626, 33161.66838331586, 38999.0, 43711.78144109259, 44759.0, 45590.77204613956, 46673.53326466692, 34296.628134875325, 34750.0, 34950.0, 34985.30029399347, 36060.639393606776, 34991.475127872596, 34993.65006349904, 35273.0, 35489.290214195054, 35550.0, 35322.823385882904, 36545.26909461849, 37380.25239495249, 37433.25133497261, 37450.625493744716, 28333.0, 30778.846105769328, 30866.382672346877, 31297.687023129478, 31366.020228078298, 23569.64645530284, 24043.759562404153, 25340.493190135727, 25365.74634253634, 26330.73669263283], "unit": "score", "name": "ext.html", "value": 18075.660610957417}, {"lowerIsBetter": false, "replicates": [352.73016142650863, 356.90363601827494, 357.71204180634595, 358.0386661813031, 359.60443512136646, 15674.373025078998, 16162.595935101614, 16917.7462338065, 17182.914085429587, 17626.823731762677, 11052.613158539452, 11513.827292590619, 16758.58103547409, 16790.160491975414, 16826.747598786027, 4592.701474404162, 5284.207368894658, 5299.735013249341, 5314.149736042234, 5322.148456247001, 4708.964027913854, 5015.322931404268, 5190.558802501791, 5282.894342113155, 5289.788408463657, 5346.625736198468, 5357.464253574651, 5404.729763511828, 5646.153077038456, 5676.631018983773, 5545.473180047889, 5685.289338832646, 5730.226419433365, 5960.539667781378, 5966.0, 5294.867628309285, 5308.70802105884, 5313.920291195635, 5322.121849894763, 5336.706481143536, 16895.493135205965, 19278.32525861602, 19921.402357929284, 20170.39488815338, 20387.89806050975, 1920.5486710622993, 1965.8918759468224, 2088.4674408025858, 2102.5479521902867, 2244.831637627168, 9452.054794520562, 9496.240300775922, 9541.188998935098, 9582.808343833154, 9672.22622190223, 1797.3888877781487, 1813.7007393780011, 1824.3067634298882, 1824.8266414690584, 1890.6596812573732, 55478.0, 57952.42047579512, 57956.420435795524, 58359.83280334412, 58591.41408585945, 9729.513524323755, 9851.802963940825, 9883.703488895344, 9929.900700993043, 10027.0, 12467.5012999479, 12563.309018004098, 12563.937180314222, 12571.5599954003, 12584.874151258553, 7338.486305958531, 7344.889826652605, 7365.447591430664, 7373.29953654402, 7411.888821667571, 7054.682539285642, 7077.469189810682, 7101.467389945775, 7103.076600041962, 7128.144622645315, 4383.956160438419, 4386.4736231652405, 4425.535318791545, 4437.866863994085, 4496.7301961882395, 1701.3109690575088, 1770.6016146366965, 1771.7430972508914, 1831.752713383676, 1869.1495369606796, 919.4391421233042, 944.7071407863584, 970.4710932541782, 985.4875464758286, 998.9610804762965, 14419.206943617992, 15253.771193432107, 15278.541643750705, 15729.764053539206, 15784.210789460481, 907.8184363127401, 914.5884352041608, 960.7934294126796, 975.4976187263564, 977.7946631207384, 9028.593713282919, 9128.40665356763, 9250.86123708145, 9334.953325233466, 9712.854307185256, 531973.0, 538906.0, 547523.0, 554247.0, 560355.0, 71138.0, 71212.64393678102, 71959.2804071963, 72105.31315464478, 73160.26839731641, 1150.8791576884307, 1180.9822852657217, 1189.8096304591224, 1190.2739329009298, 1192.5051103792002, 14776.33506492189, 14946.402143914556, 15007.32467038964, 15334.463293784664, 15651.608709782347, 32817.83591082029, 33363.666363337026, 33582.32835343328, 34068.318633627685, 34794.78218262349, 42949.1410171801, 43079.0, 43164.568354317315, 43921.34117988169, 44035.77982110069, 7060.470464715064, 7266.1280646322775, 7371.963140184479, 7469.253074692488, 7516.774496765106, 9423.057694230522, 10490.580376784843, 11010.39442830652, 11128.888711112786, 11390.715232119263, 8894.866577001221, 9036.774080648036, 9601.951990240004, 9602.08780165883, 9637.42175469474, 9456.19622332082, 9552.761180970532, 9617.374870633386, 9985.550650220903, 10123.139533139765, 9250.074992500697, 9331.346805723535, 9494.335396522178, 9522.619095236112, 9605.711828645151, 7327.303906128909, 7501.174870764103, 7538.396928245617, 7591.772246832604, 7630.961845190961, 8627.91372086271, 9741.172000380047, 9873.407595544002, 10023.849642255518, 10061.748456288651], "unit": "score", "name": "jquery.html", "value": 8107.634616394542}, {"lowerIsBetter": false, "replicates": [1487.3753023730035, 1509.1850400783574, 1675.2377668160989, 1782.1801971093296, 1812.3475548802428, 7372.3364897159245, 7462.365698915592, 7633.389328853692, 7646.044244469442, 7682.807929801751, 7464.365528930034, 7514.211007844179, 7518.54888706678, 7593.126790419104, 7593.2027137150635, 2322.256877799105, 2335.2177020698086, 2344.9062037518565, 2346.741858395575, 2348.8590684558894, 2317.6523521471745, 2327.1156960355124, 2336.9532609347802, 2359.4337359033793, 2368.8933997970134, 2245.8203343732544, 2313.375388645065, 2317.03842905195, 2321.9535609287886, 2337.1002164166835, 2294.9426264343356, 2332.323626148415, 2367.1596583213054, 2368.1119580157356, 2375.192434572245, 2377.2868139558063, 2388.0805889732405, 2391.091385273602, 2397.412633904687, 2399.964000539976, 7293.0519032525435, 7353.48525603208, 7377.852442951111, 7382.22486638906, 7399.3710534604625, 4681.46163191234, 4725.40932383452, 4749.691270067435, 4763.571278584909, 4788.976055119737, 3109.455845227076, 3157.5579418881375, 3201.3597280543986, 3203.423383790917, 3211.550382946366, 1000.229823036258, 1008.6806159411294, 1013.6705570689481, 1022.437659287389, 1048.5229220704562, 10348.896511034944, 10387.428691421968, 10467.371957682564, 10471.581136754521, 10485.318454300523, 4184.2468355695655, 4260.616544511009, 4317.633001194934, 4325.0, 4353.717008394444, 8459.069502354736, 8462.534560599102, 8464.195901389357, 8474.703385381605, 8484.448510846774, 4662.137504561599, 4688.4373875134515, 4693.835715749932, 4709.717416954925, 4725.40932383452, 4308.202982448257, 4312.353147027971, 4335.7181783184, 4362.367456718758, 4370.890727731832, 3444.50054742061, 3450.810205438675, 3452.5339079224486, 3480.564929383827, 3488.3720930232294, 1068.6847380022912, 1078.229066217658, 1099.8350247462783, 1101.1906248907046, 1126.9943650281696, 1311.6065180445828, 1315.5724389573236, 1315.8223639808502, 1327.0312671749484, 1346.1048402812216, 7047.365737083687, 7146.142462904485, 7174.820629484305, 7176.246494118147, 7188.137423509108, 1126.1272513801705, 1133.8355938388888, 1140.520981187903, 1141.8629764428322, 1147.0536807134147, 5583.664980101207, 5722.914156287659, 5794.101914203306, 5814.912776308359, 5818.79634212809, 8933.19601235892, 9113.863292050624, 9403.623855045722, 9449.574769135406, 9491.0, 9154.450732956044, 9247.445153290824, 9255.722328330161, 9268.768280793034, 9302.069793020644, 7047.647617619098, 7172.354488096096, 7173.605451700102, 7187.2453392393045, 7192.31672991065, 6908.447324214151, 6930.792076237721, 6951.582905025714, 6978.302169782981, 6983.406410455168, 8034.995625546807, 8049.074356449083, 8178.754637360888, 8200.220979006985, 8298.502089874626, 8235.0, 8366.288865446506, 8408.411411201158, 8413.158684131538, 8423.0, 6337.651429171256, 6409.935900640934, 6577.309382514767, 6579.407853293226, 6589.17635295588, 7233.602151881697, 7236.312550307923, 7250.854982900418, 7263.491555591269, 7311.634418279171, 6666.533342666161, 6787.762428314985, 6815.216250131299, 6975.9302406975285, 7059.5764254144915, 6473.805785826433, 6480.44916182111, 6503.73985040612, 6605.273419923708, 6623.4038936495945, 6787.762428314985, 6801.0, 6802.591844489347, 6821.693023814039, 6822.044913712183, 6158.107074474086, 6245.656488893154, 6272.121902933502, 6312.116303717391, 6321.367863213642, 6192.659403732838, 6269.843253918506, 6270.6864656766065, 6274.780382686584, 6287.2769631492965], "unit": "score", "name": "mootools.html", "value": 4453.20001935199}, {"lowerIsBetter": false, "replicates": [328.4383703866388, 332.4033360118587, 333.9532465454835, 337.86823138975797, 338.70701842905896, 6219.098230756537, 6232.750689972401, 6266.091416744575, 6308.085327627503, 6445.097686323918, 6220.129181914535, 6260.154879091333, 6266.905996410058, 6273.498120150389, 6276.466500347476, 4740.407449068875, 4753.33453316536, 4754.049190161964, 4762.857114286559, 4763.880902977418, 4733.881652958669, 4743.288506724001, 4772.069446457942, 4774.904501909959, 4779.90440191196, 4636.652251081166, 4713.811447542094, 4727.1254817858635, 4728.101660684476, 4734.171519984006, 4712.434507859079, 4713.787879545412, 4715.457722361938, 4716.457607375161, 4719.952800472003, 4059.857904973341, 4070.837166513336, 4077.673786097105, 4083.4079058536345, 4084.9591504084874, 5958.493528050121, 5982.670953097578, 5989.3112292086535, 6001.4298641628975, 6002.129691194752, 5367.892642147135, 5505.642133261325, 5513.751881165357, 5526.530244929186, 5531.861703457405, 6681.966590167067, 6688.29772873851, 6696.397324240842, 6699.598024118569, 6701.3968742812895, 4518.5481451854885, 4530.592246697813, 4540.091981603692, 4541.205289074399, 4550.249208880531, 6798.184217893835, 6911.723531058751, 6926.619035953021, 6929.341712537301, 6971.675381677465, 4608.193566125915, 4617.746023968714, 4626.259798432302, 4632.050429661911, 4645.279981602857, 4687.601553867959, 4689.273162659793, 4702.130105930414, 4703.482616912137, 4714.0, 5489.533389661923, 5490.69801160932, 5496.065668836308, 5496.422875598005, 5508.807191748269, 6633.803660167246, 6637.369449902251, 6715.160604924385, 6716.664166791641, 6735.057092007123, 1600.4718442914043, 1625.3417365966802, 1626.414490783317, 1632.8285530019177, 1635.5175223309152, 1065.7761870007384, 1070.6680928912062, 1074.4412905289205, 1075.6772968109535, 1084.3385534823751, 6207.441330280297, 6269.968650156811, 6285.59143655661, 6287.748490060438, 6288.968555157195, 6724.562903411263, 6753.0, 6792.762253321209, 6809.319068093151, 6828.112345395067, 6148.292946311231, 6179.104029915637, 6187.876242475125, 6190.102435146879, 6190.7523699051535, 3670.944935825965, 3679.889603311905, 3683.447482877536, 3685.391910334765, 3693.8891833245048, 7117.074780278531, 7119.92880071203, 7126.893096603555, 7127.251638577978, 7142.785716428515, 6767.52627316093, 6909.447244220451, 6980.406665433394, 6980.581165130108, 6994.300569943067, 7084.149902011689, 7090.574565526085, 7111.111111111111, 7122.501424900207, 7131.821704457327, 6782.389584937379, 6782.728690852508, 6786.3892249697765, 6802.455803535804, 6804.795856124324, 6582.275949645439, 6710.798676039727, 6728.562643428161, 6740.427063699641, 6746.5277430581355, 7060.046893669494, 7077.929220707727, 7078.787636370917, 7081.752138675121, 7082.822929426599, 4585.151746926829, 4587.908241835212, 4599.747013914267, 4607.884802879955, 4612.561806628365, 6717.361850624183, 6739.19129704419, 6741.426978706865, 6792.422644075309, 6944.236134025152, 6711.228208756055, 6730.831729206809, 6733.124693789776, 6738.66306684654, 6763.425108865801, 6667.833304167435, 6671.8665626686225, 6673.0, 6677.3656502632175, 6678.699458524281, 6431.163948686828, 6550.213974323112, 6665.166854143232, 6671.366220209073, 6682.131322927989, 6758.324167583202, 6769.3907548320885, 6784.626845523346, 6785.898211526733, 6793.4565234782085, 6553.934460655332, 6608.43828274602, 6617.073609694743, 6623.867522649616, 6624.403803657694], "unit": "score", "name": "prototype.html", "value": 4970.749427919168}, {"lowerIsBetter": false, "replicates": [721.9350258476736, 723.7394537966335, 738.0, 827.189354432656, 836.3267569606467, 13052.216866987987, 13071.085024048309, 13079.215247085182, 13090.21458712478, 13209.075364724473, 12691.619251422471, 12703.618891433272, 12740.681482962907, 12746.872531274685, 12781.360931953412, 667.87310411022, 681.4888833374969, 753.9472236943416, 764.8164440534259, 771.3559178086276, 800.0998876264202, 807.6244546285976, 811.8295158016823, 817.4604760857835, 818.1327792539927, 867.4231635962078, 874.0254616103031, 874.6545114679698, 875.0986483921571, 877.2280393253927, 852.7441767469766, 854.0264098927228, 855.8587833007547, 857.6140736668493, 860.7761981884723, 629.9401556852092, 635.6916895305773, 636.901280301554, 637.5473413876153, 641.1888960465016, 13548.45806167752, 13561.45754169832, 13588.25264610446, 13602.591922242249, 13633.863661363359, 12966.351682415936, 13027.739445211042, 13204.207747535178, 13294.534691285759, 13413.932930335384, 10195.694129176136, 10340.37957722539, 10483.161347092215, 10510.579576816917, 10522.0, 3613.313470440608, 3657.8536858525895, 3664.193877347006, 3781.243751249761, 3782.867599634, 46759.29861052087, 46877.29684054742, 46932.53067469316, 47290.527094728954, 48397.0, 10137.391756494486, 10140.898591013995, 10159.796804063877, 10220.233482488844, 10428.634997775041, 18512.537186570444, 18564.164612592467, 18613.90693046553, 18625.7206141908, 18716.625667486845, 7602.353799927068, 7603.46775725705, 7828.960855195687, 7886.566238856918, 8020.318272946748, 4177.039280965395, 4183.97908010458, 4215.093754842724, 4305.784710764449, 4350.956490435118, 3120.516319970363, 3125.4842950912844, 3141.9057428277188, 3163.8259895705955, 3169.0968074098773, 585.4321308330913, 591.5977135547869, 601.2334273800851, 607.4563265877104, 613.4969325153331, 533.4798571392861, 547.258464780225, 597.2683462758087, 648.3415324616166, 660.323168752033, 8360.958195209107, 8598.656053757904, 8878.334124940655, 8922.107789221025, 9090.727278181665, 521.9660722053054, 526.3578434310135, 536.6672662948996, 572.699332850257, 665.3379887012453, 3850.8267127979307, 4078.1232035112, 4117.855875044419, 4137.50349958007, 4183.644390226865, 56687.0, 56950.715246423504, 60294.69852650708, 60860.69569652124, 61066.38933610607, 49583.504164957885, 50045.49954500408, 51288.487115129115, 51489.742551287, 51954.74022629863, 46586.06827863424, 47307.0, 47364.0, 48038.759806200746, 48115.0, 8868.512231827053, 9200.585973631336, 9218.539073046186, 9270.119338663086, 9282.35023548345, 33785.15537111592, 34544.30911381808, 34736.478952815225, 34836.65163348334, 34936.0, 40484.0, 40844.0, 40981.79509102435, 40986.0, 41131.383029253986, 11205.887941120485, 11348.489317980546, 11492.712682183012, 11582.07343412508, 11585.198902811066, 12616.432260548114, 12733.363331833556, 12776.74446511046, 13390.598282051555, 13524.93237533806, 10859.891401085888, 10913.56345746193, 11203.831942521032, 11213.215074945001, 11443.427828608703, 11593.710157246136, 11895.524179032742, 11951.402429878644, 12311.138220324492, 12388.0, 11622.360770157722, 11694.590689325832, 12126.333051682243, 12233.0, 12364.319962401794, 9416.458754108673, 9547.618095276111, 9631.614735410785, 9633.32566720351, 9847.753806154904, 9422.0, 10421.0, 10519.526621302213, 10562.788744225227, 10613.310134841211], "unit": "score", "name": "yui.html", "value": 6338.724081837691}], "name": "dromaeo_css", "value": 6917.470010731895}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 104.0, 110.0, 109.0, 110.0, 121.0, 111.0, 109.0, 110.0, 108.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [151.0, 126.0, 149.0, 160.0, 128.0, 146.0, 155.0, 127.0, 164.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 163.0, 162.0, 164.0, 160.0, 164.0, 171.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 71.0, 75.0, 74.0, 72.0, 150.0, 75.0, 75.0, 71.0], "unit": "score", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 145.0, 95.0, 96.0, 96.0, 149.0, 96.0, 96.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 111.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 97.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [59.0, 61.0, 57.0, 57.0, 57.0, 60.0, 58.0, 57.0, 66.0, 61.0], "unit": "score", "name": "json-parse-financial", "value": 59.3}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 67.0, 67.0, 69.0, 67.0, 67.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 84.0, 84.0, 86.0, 85.0, 84.0, 84.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 127.0, 122.0, 115.0, 119.0, 130.0, 123.0, 115.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.8}, {"lowerIsBetter": true, "replicates": [131.0, 145.0, 144.0, 143.0, 140.0, 132.0, 142.0, 141.0, 142.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.3}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 68.0, 67.0, 65.0, 67.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1501.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.9727834362999], "unit": "score", "name": "Richards", "value": 211.42367800000002}, {"lowerIsBetter": false, "replicates": [187.68768768768768], "unit": "score", "name": "DeltaBlue", "value": 352.2767040000001}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1055.9662090813094], "unit": "score", "name": "RayTrace", "value": 700.7695829999997}, {"lowerIsBetter": false, "replicates": [702.7406886858749], "unit": "score", "name": "Earley", "value": 948.3768489999995}, {"lowerIsBetter": false, "replicates": [12329.268292682927], "unit": "score", "name": "Boyer", "value": 54.05535707220569}, {"lowerIsBetter": false, "replicates": [41530.61224489796], "unit": "score", "name": "RegExp", "value": 21.935265356265376}, {"lowerIsBetter": false, "replicates": [592.0663114268798], "unit": "score", "name": "Splay", "value": 137.63829900000002}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20453.275289146004}]} 20:22:25 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20453.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1501.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6917.47"}}} 20:22:25 INFO - Return code: 0 20:22:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:22:25 INFO - # TBPL SUCCESS # 20:22:25 INFO - Running post-action listener: _resource_record_post_action 20:22:25 INFO - Running post-run listener: _resource_record_post_run 20:22:26 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 553533440; Read time: 0; Write time: 370308 20:22:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 233975808; Read time: 0; Write time: 168064 20:22:26 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 315650048; Read time: 0; Write time: 202176 20:22:26 INFO - Running post-run listener: _upload_blobber_files 20:22:26 INFO - Blob upload gear active. 20:22:26 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:22:26 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:22:26 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:22:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:22:27 INFO - (blobuploader) - INFO - Open directory for files ... 20:22:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:22:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:22:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:22:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:22:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:22:28 INFO - (blobuploader) - INFO - Done attempting. 20:22:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:22:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:22:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:22:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:22:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:22:29 INFO - (blobuploader) - INFO - Done attempting. 20:22:29 INFO - (blobuploader) - INFO - Iteration through files over. 20:22:29 INFO - Return code: 0 20:22:29 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:22:29 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:22:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8b390558eb6556211ab72498b06ca00506921bffb6150e1dd0fa953c59646421cd926315de53587e0378c65c12502a2432c5c187ce773f9897b26f189ce683e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07ba631da41d89741ccd16174c0b79252756aba2a8b7ff1c684a2e98dbccebe4503585fb8e9dc09363967458dbe69a9c97b778c717d6640f3e6a33102ea6f62b"} 20:22:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:22:29 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:22:29 INFO - Contents: 20:22:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8b390558eb6556211ab72498b06ca00506921bffb6150e1dd0fa953c59646421cd926315de53587e0378c65c12502a2432c5c187ce773f9897b26f189ce683e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07ba631da41d89741ccd16174c0b79252756aba2a8b7ff1c684a2e98dbccebe4503585fb8e9dc09363967458dbe69a9c97b778c717d6640f3e6a33102ea6f62b"} 20:22:29 INFO - Running post-run listener: copy_logs_to_upload_dir 20:22:29 INFO - Copying logs to upload dir... 20:22:29 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:22:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.160632 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-17 20:22:28.894918) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-17 20:22:28.898003) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8b390558eb6556211ab72498b06ca00506921bffb6150e1dd0fa953c59646421cd926315de53587e0378c65c12502a2432c5c187ce773f9897b26f189ce683e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07ba631da41d89741ccd16174c0b79252756aba2a8b7ff1c684a2e98dbccebe4503585fb8e9dc09363967458dbe69a9c97b778c717d6640f3e6a33102ea6f62b"} build_url:https://queue.taskcluster.net/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011520 build_url: 'https://queue.taskcluster.net/v1/task/Hcz9Bo1sQReR-3zePIvy3g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f8b390558eb6556211ab72498b06ca00506921bffb6150e1dd0fa953c59646421cd926315de53587e0378c65c12502a2432c5c187ce773f9897b26f189ce683e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/07ba631da41d89741ccd16174c0b79252756aba2a8b7ff1c684a2e98dbccebe4503585fb8e9dc09363967458dbe69a9c97b778c717d6640f3e6a33102ea6f62b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-17 20:22:28.922571) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 20:22:28.922875) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1453083039.459706-1562249503 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-17 20:22:29.008368) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-17 20:22:29.008686) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-17 20:22:29.008948) ========= ========= Total master_lag: 0.52 =========