builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1451912125.44 results: success (0) buildid: 20160104023003 builduid: cdeb86d5db1b42cf845179e2a068e9b7 revision: 8060449a6dd05e89690e957c1e88230c6ff6e1d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.442100) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.442760) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.443079) ========= 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=523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006261 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.469099) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.469421) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.484982) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.485287) ========= 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=523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004398 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.548076) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.548354) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.548725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.549023) ========= 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=523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 04:55:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.8M=0s 2016-01-04 04:55:25 (33.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163872 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.725307) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.725637) ========= 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=523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.775853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:25.776206) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 8060449a6dd05e89690e957c1e88230c6ff6e1d4 --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 8060449a6dd05e89690e957c1e88230c6ff6e1d4 --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=523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 04:55:25,991 truncating revision to first 12 chars 2016-01-04 04:55:25,991 Setting DEBUG logging. 2016-01-04 04:55:25,991 attempt 1/10 2016-01-04 04:55:25,991 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/8060449a6dd0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 04:55:26,611 unpacking tar archive at: fx-team-8060449a6dd0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.929627 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:26.718377) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:26.718693) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:26.728596) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:26.728911) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 04:55:26.729327) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-04 04:55:26.729625) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:55:27 INFO - MultiFileLogger online at 20160104 04:55:27 in /builds/slave/test-pgo 04:55:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:55:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 04:55:27 INFO - {'append_to_log': False, 04:55:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 04:55:27 INFO - 'blob_upload_branch': 'Fx-Team', 04:55:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 04:55:27 INFO - 'branch': 'Fx-Team', 04:55:27 INFO - 'buildbot_json_path': 'buildprops.json', 04:55:27 INFO - 'config_files': ('talos/linux_config.py',), 04:55:27 INFO - 'default_actions': ('clobber', 04:55:27 INFO - 'read-buildbot-config', 04:55:27 INFO - 'download-and-extract', 04:55:27 INFO - 'populate-webroot', 04:55:27 INFO - 'create-virtualenv', 04:55:27 INFO - 'install', 04:55:27 INFO - 'run-tests'), 04:55:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:55:27 INFO - 'download_minidump_stackwalk': True, 04:55:27 INFO - 'download_symbols': 'ondemand', 04:55:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:55:27 INFO - 'tooltool.py': '/tools/tooltool.py', 04:55:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:55:27 INFO - '/tools/misc-python/virtualenv.py')}, 04:55:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:55:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:55:27 INFO - 'installer_path': 'installer.exe', 04:55:27 INFO - 'log_level': 'info', 04:55:27 INFO - 'log_name': 'talos', 04:55:27 INFO - 'log_to_console': True, 04:55:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:55:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:55:27 INFO - 'opt_config_files': (), 04:55:27 INFO - 'pip_index': False, 04:55:27 INFO - 'sps_profile': False, 04:55:27 INFO - 'sps_profile_interval': 0, 04:55:27 INFO - 'suite': 'dromaeojs', 04:55:27 INFO - 'system_bits': '32', 04:55:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:55:27 INFO - 'title': 'talos-linux64-ix-065', 04:55:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:55:27 INFO - 'use_talos_json': True, 04:55:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 04:55:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:55:27 INFO - 'work_dir': 'build'} 04:55:27 INFO - ##### 04:55:27 INFO - ##### Running clobber step. 04:55:27 INFO - ##### 04:55:27 INFO - Running pre-action listener: _resource_record_pre_action 04:55:27 INFO - Running main action method: clobber 04:55:27 INFO - rmtree: /builds/slave/test-pgo/build 04:55:27 INFO - Running post-action listener: _resource_record_post_action 04:55:27 INFO - ##### 04:55:27 INFO - ##### Running read-buildbot-config step. 04:55:27 INFO - ##### 04:55:27 INFO - Running pre-action listener: _resource_record_pre_action 04:55:27 INFO - Running main action method: read_buildbot_config 04:55:27 INFO - Using buildbot properties: 04:55:27 INFO - { 04:55:27 INFO - "project": "", 04:55:27 INFO - "product": "firefox", 04:55:27 INFO - "script_repo_revision": "production", 04:55:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 04:55:27 INFO - "repository": "", 04:55:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 04:55:27 INFO - "buildid": "20160104023003", 04:55:27 INFO - "pgo_build": "True", 04:55:27 INFO - "basedir": "/builds/slave/test-pgo", 04:55:27 INFO - "buildnumber": 566, 04:55:27 INFO - "slavename": "talos-linux64-ix-065", 04:55:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:55:27 INFO - "platform": "ubuntu64_hw", 04:55:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:55:27 INFO - "branch": "fx-team", 04:55:27 INFO - "repo_path": "integration/fx-team", 04:55:27 INFO - "revision": "8060449a6dd05e89690e957c1e88230c6ff6e1d4", 04:55:27 INFO - "stage_platform": "linux64-pgo", 04:55:27 INFO - "builduid": "cdeb86d5db1b42cf845179e2a068e9b7", 04:55:27 INFO - "slavebuilddir": "test" 04:55:27 INFO - } 04:55:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:55:27 INFO - Running post-action listener: _resource_record_post_action 04:55:27 INFO - ##### 04:55:27 INFO - ##### Running download-and-extract step. 04:55:27 INFO - ##### 04:55:27 INFO - Running pre-action listener: _resource_record_pre_action 04:55:27 INFO - Running main action method: download_and_extract 04:55:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 04:55:27 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')]} 04:55:27 INFO - https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:55:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/test_packages.json 04:55:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/test_packages.json 04:55:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 04:55:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 04:55:27 INFO - Downloaded 1302 bytes. 04:55:27 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 04:55:27 INFO - Using the following test package requirements: 04:55:27 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:55:27 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:55:27 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:27 INFO - u'jsshell-linux-x86_64.zip'], 04:55:27 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:55:27 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:55:27 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:55:27 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:55:27 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:55:27 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:55:27 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:55:27 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:55:27 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:55:27 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')]} 04:55:27 INFO - https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:55:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:55:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:55:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/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 04:55:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/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 04:55:29 INFO - Downloaded 23199260 bytes. 04:55:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:55:29 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:55:29 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:55:30 INFO - Return code: 0 04:55:30 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 04:55: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')]} 04:55:30 INFO - https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:55:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:55:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:55:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/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 04:55:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/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 04:55:32 INFO - Downloaded 23199260 bytes. 04:55:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 04:55:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:55:32 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 04:55:34 INFO - Return code: 0 04:55:34 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')]} 04:55:34 INFO - https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:55:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:55:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:55:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/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 04:55:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/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 04:55:35 INFO - Downloaded 11132285 bytes. 04:55:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 04:55:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:55:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 04:55:36 INFO - Return code: 0 04:55: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')]} 04:55:36 INFO - https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:55:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:55:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:55:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/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 04:55:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/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 04:55:38 INFO - Downloaded 54978014 bytes. 04:55:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:55:38 INFO - mkdir: /builds/slave/test-pgo/properties 04:55:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 04:55:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 04:55:38 INFO - Contents: 04:55:38 INFO - build_url:https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:55:38 INFO - Running post-action listener: _resource_record_post_action 04:55:38 INFO - Running post-action listener: set_extra_try_arguments 04:55:38 INFO - ##### 04:55:38 INFO - ##### Running populate-webroot step. 04:55:38 INFO - ##### 04:55:38 INFO - Running pre-action listener: _resource_record_pre_action 04:55:38 INFO - Running main action method: populate_webroot 04:55:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:55:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:55:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:55:38 INFO - '--tppagecycles', 04:55:38 INFO - '7'], 04:55:38 INFO - 'tests': ['tsvgm']}}, 04:55:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:55:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:55:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:55:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:55:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:55:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:55:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:55:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:38 INFO - 'talos_options': ['--e10s'], 04:55:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:55:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:38 INFO - 'tests': ['damp', 'tps']}, 04:55:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:38 INFO - 'talos_options': ['--e10s'], 04:55:38 INFO - 'tests': ['damp', 'tps']}, 04:55:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:55:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:55:38 INFO - 'other': {'tests': ['a11yr', 04:55:38 INFO - 'ts_paint', 04:55:38 INFO - 'tpaint', 04:55:38 INFO - 'sessionrestore', 04:55:38 INFO - 'sessionrestore_no_auto_restore']}, 04:55:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:55:38 INFO - 'tests': ['a11yr', 04:55:38 INFO - 'ts_paint', 04:55:38 INFO - 'tpaint', 04:55:38 INFO - 'sessionrestore', 04:55:38 INFO - 'sessionrestore_no_auto_restore']}, 04:55:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:55:38 INFO - 'tests': ['a11yr', 04:55:38 INFO - 'ts_paint', 04:55:38 INFO - 'tpaint', 04:55:38 INFO - 'sessionrestore', 04:55:38 INFO - 'sessionrestore_no_auto_restore']}, 04:55:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:55:38 INFO - 'tests': ['a11yr', 04:55:38 INFO - 'ts_paint', 04:55:38 INFO - 'tpaint', 04:55:38 INFO - 'sessionrestore', 04:55:38 INFO - 'sessionrestore_no_auto_restore']}, 04:55:38 INFO - 'other_l64': {'tests': ['a11yr', 04:55:38 INFO - 'ts_paint', 04:55:38 INFO - 'tpaint', 04:55:38 INFO - 'sessionrestore', 04:55:38 INFO - 'sessionrestore_no_auto_restore']}, 04:55:38 INFO - 'other_nol64': {'tests': ['a11yr', 04:55:38 INFO - 'ts_paint', 04:55:38 INFO - 'tpaint', 04:55:38 INFO - 'sessionrestore', 04:55:38 INFO - 'sessionrestore_no_auto_restore']}, 04:55:38 INFO - 'svgr': {'tests': ['tsvgx', 04:55:38 INFO - 'tsvgr_opacity', 04:55:38 INFO - 'tart', 04:55:38 INFO - 'tscrollx', 04:55:38 INFO - 'cart']}, 04:55:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:55:38 INFO - 'tests': ['tsvgx', 04:55:38 INFO - 'tsvgr_opacity', 04:55:38 INFO - 'tart', 04:55:38 INFO - 'tscrollx', 04:55:38 INFO - 'cart']}, 04:55:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:38 INFO - 'tests': ['tp5o']}, 04:55:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:38 INFO - 'talos_options': ['--e10s'], 04:55:38 INFO - 'tests': ['tp5o']}, 04:55:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:38 INFO - 'talos_options': ['--xperf_path', 04:55:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:55:38 INFO - 'tests': ['tp5n']}, 04:55:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:55:38 INFO - 'talos_options': ['--e10s', 04:55:38 INFO - '--xperf_path', 04:55:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:55:38 INFO - 'tests': ['tp5n']}}, 04:55:38 INFO - 'talos.zip': {'path': '', 04:55:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:55:38 INFO - Running post-action listener: _resource_record_post_action 04:55:38 INFO - ##### 04:55:38 INFO - ##### Running create-virtualenv step. 04:55:38 INFO - ##### 04:55:38 INFO - Running pre-action listener: _resource_record_pre_action 04:55:38 INFO - Running main action method: create_virtualenv 04:55:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 04:55:38 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 04:55:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 04:55:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:55:38 INFO - Using real prefix '/usr' 04:55:38 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 04:55:39 INFO - Installing distribute.............................................................................................................................................................................................done. 04:55:41 INFO - Installing pip.................done. 04:55:41 INFO - Return code: 0 04:55:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 04:55: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')]} 04:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55: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')]} 04:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa3aea94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc840>, '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 0x25396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2539b60>, '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': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', '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 04:55: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 04:55: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 pip>=1.5 04:55:41 INFO - Using env: {'DISPLAY': ':0', 04:55:41 INFO - 'HOME': '/home/cltbld', 04:55:41 INFO - 'LANG': 'en_US.UTF-8', 04:55:41 INFO - 'LANGUAGE': 'en_US:en', 04:55:41 INFO - 'LOGNAME': 'cltbld', 04:55:41 INFO - 'MAIL': '/var/mail/cltbld', 04:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:41 INFO - 'MOZ_NO_REMOTE': '1', 04:55:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:41 INFO - 'NO_EM_RESTART': '1', 04:55:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:41 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:41 INFO - 'SHELL': '/bin/bash', 04:55:41 INFO - 'SHLVL': '1', 04:55:41 INFO - 'TERM': 'linux', 04:55:41 INFO - 'TMOUT': '86400', 04:55:41 INFO - 'USER': 'cltbld', 04:55:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', 04:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:41 INFO - '_': '/tools/buildbot/bin/python'} 04:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:41 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 04:55:41 INFO - Cleaning up... 04:55:41 INFO - Return code: 0 04:55:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 04:55: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')]} 04:55:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55: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')]} 04:55:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55: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', '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 0x7fa3aea94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc840>, '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 0x25396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2539b60>, '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': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', '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 04:55: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 04:55: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 psutil>=0.7.1 04:55:41 INFO - Using env: {'DISPLAY': ':0', 04:55:41 INFO - 'HOME': '/home/cltbld', 04:55:41 INFO - 'LANG': 'en_US.UTF-8', 04:55:41 INFO - 'LANGUAGE': 'en_US:en', 04:55:41 INFO - 'LOGNAME': 'cltbld', 04:55:41 INFO - 'MAIL': '/var/mail/cltbld', 04:55:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:41 INFO - 'MOZ_NO_REMOTE': '1', 04:55:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:41 INFO - 'NO_EM_RESTART': '1', 04:55:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:41 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:41 INFO - 'SHELL': '/bin/bash', 04:55:41 INFO - 'SHLVL': '1', 04:55:41 INFO - 'TERM': 'linux', 04:55:41 INFO - 'TMOUT': '86400', 04:55:41 INFO - 'USER': 'cltbld', 04:55:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', 04:55:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:41 INFO - '_': '/tools/buildbot/bin/python'} 04:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:41 INFO - Downloading/unpacking psutil>=0.7.1 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55:43 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 04:55:43 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:55:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 04:55:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:55:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:55:43 INFO - Installing collected packages: psutil 04:55:43 INFO - Running setup.py install for psutil 04:55:43 INFO - building 'psutil._psutil_linux' extension 04:55:43 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 04:55:43 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 04:55:43 INFO - building 'psutil._psutil_posix' extension 04:55:43 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 04:55:43 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 04:55:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:55:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:55:43 INFO - Successfully installed psutil 04:55:43 INFO - Cleaning up... 04:55:43 INFO - Return code: 0 04:55:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 04:55:43 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')]} 04:55:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:43 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')]} 04:55:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:43 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 0x7fa3aea94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc840>, '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 0x25396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2539b60>, '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': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', '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 04:55:43 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 04:55:43 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 04:55:43 INFO - Using env: {'DISPLAY': ':0', 04:55:43 INFO - 'HOME': '/home/cltbld', 04:55:43 INFO - 'LANG': 'en_US.UTF-8', 04:55:43 INFO - 'LANGUAGE': 'en_US:en', 04:55:43 INFO - 'LOGNAME': 'cltbld', 04:55:43 INFO - 'MAIL': '/var/mail/cltbld', 04:55:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:43 INFO - 'MOZ_NO_REMOTE': '1', 04:55:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:43 INFO - 'NO_EM_RESTART': '1', 04:55:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:43 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:43 INFO - 'SHELL': '/bin/bash', 04:55:43 INFO - 'SHLVL': '1', 04:55:43 INFO - 'TERM': 'linux', 04:55:43 INFO - 'TMOUT': '86400', 04:55:43 INFO - 'USER': 'cltbld', 04:55:43 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', 04:55:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:43 INFO - '_': '/tools/buildbot/bin/python'} 04:55:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:55:44 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 04:55:44 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 04:55:44 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 04:55:44 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 04:55:44 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 04:55:44 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 04:55:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:55:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:55:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:55:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:55:45 INFO - Installing collected packages: mozsystemmonitor 04:55:45 INFO - Running setup.py install for mozsystemmonitor 04:55:46 INFO - Successfully installed mozsystemmonitor 04:55:46 INFO - Cleaning up... 04:55:46 INFO - Return code: 0 04:55:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 04:55:46 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')]} 04:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:46 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')]} 04:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:46 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 0x7fa3aea94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc840>, '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 0x25396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2539b60>, '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': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', '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 04:55:46 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 04:55:46 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 04:55:46 INFO - Using env: {'DISPLAY': ':0', 04:55:46 INFO - 'HOME': '/home/cltbld', 04:55:46 INFO - 'LANG': 'en_US.UTF-8', 04:55:46 INFO - 'LANGUAGE': 'en_US:en', 04:55:46 INFO - 'LOGNAME': 'cltbld', 04:55:46 INFO - 'MAIL': '/var/mail/cltbld', 04:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:46 INFO - 'MOZ_NO_REMOTE': '1', 04:55:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:46 INFO - 'NO_EM_RESTART': '1', 04:55:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:46 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:46 INFO - 'SHELL': '/bin/bash', 04:55:46 INFO - 'SHLVL': '1', 04:55:46 INFO - 'TERM': 'linux', 04:55:46 INFO - 'TMOUT': '86400', 04:55:46 INFO - 'USER': 'cltbld', 04:55:46 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', 04:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:46 INFO - '_': '/tools/buildbot/bin/python'} 04:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:46 INFO - Downloading/unpacking blobuploader==1.2.4 04:55:46 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 04:55:46 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 04:55:46 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 04:55:46 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 04:55:46 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 04:55:46 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 04:55:48 INFO - Downloading blobuploader-1.2.4.tar.gz 04:55:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:55:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:55:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:55:48 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 04:55:48 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 04:55:48 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 04:55:48 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 04:55:48 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 04:55:48 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 04:55:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:55:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 04:55:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:55:48 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 04:55:48 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 04:55:48 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 04:55:48 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 04:55:48 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 04:55:48 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 04:55:49 INFO - Downloading docopt-0.6.1.tar.gz 04:55:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:55:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 04:55:49 INFO - Installing collected packages: blobuploader, requests, docopt 04:55:49 INFO - Running setup.py install for blobuploader 04:55:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:55:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 04:55:49 INFO - Running setup.py install for requests 04:55:49 INFO - Running setup.py install for docopt 04:55:49 INFO - Successfully installed blobuploader requests docopt 04:55:49 INFO - Cleaning up... 04:55:49 INFO - Return code: 0 04:55:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:55:49 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')]} 04:55:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:49 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')]} 04:55:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:49 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 0x7fa3aea94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc840>, '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 0x25396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2539b60>, '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': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', '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 04:55:49 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 04:55:49 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 04:55:49 INFO - Using env: {'DISPLAY': ':0', 04:55:49 INFO - 'HOME': '/home/cltbld', 04:55:49 INFO - 'LANG': 'en_US.UTF-8', 04:55:49 INFO - 'LANGUAGE': 'en_US:en', 04:55:49 INFO - 'LOGNAME': 'cltbld', 04:55:49 INFO - 'MAIL': '/var/mail/cltbld', 04:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:49 INFO - 'MOZ_NO_REMOTE': '1', 04:55:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:49 INFO - 'NO_EM_RESTART': '1', 04:55:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:49 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:49 INFO - 'SHELL': '/bin/bash', 04:55:49 INFO - 'SHLVL': '1', 04:55:49 INFO - 'TERM': 'linux', 04:55:49 INFO - 'TMOUT': '86400', 04:55:49 INFO - 'USER': 'cltbld', 04:55:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', 04:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:49 INFO - '_': '/tools/buildbot/bin/python'} 04:55:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:55:49 INFO - Running setup.py (path:/tmp/pip-17JjO5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:55:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:55:49 INFO - Running setup.py (path:/tmp/pip-iPBwPy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:55:50 INFO - Running setup.py (path:/tmp/pip-VBOW01-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:55:50 INFO - Running setup.py (path:/tmp/pip-8xzaVH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:55:50 INFO - Running setup.py (path:/tmp/pip-PJoOKh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:55:50 INFO - Running setup.py (path:/tmp/pip-74twFv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:55:50 INFO - Running setup.py (path:/tmp/pip-q0fdms-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:55:50 INFO - Running setup.py (path:/tmp/pip-Q56i7f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:55:50 INFO - Running setup.py (path:/tmp/pip-x3zBQl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:55:50 INFO - Running setup.py (path:/tmp/pip-4c_gMH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:55:50 INFO - Running setup.py (path:/tmp/pip-N_Nq79-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:55:50 INFO - Running setup.py (path:/tmp/pip-_UyHtp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:55:50 INFO - Running setup.py (path:/tmp/pip-vyxYsk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:55:50 INFO - Running setup.py (path:/tmp/pip-99L0vf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:55:50 INFO - Running setup.py (path:/tmp/pip-Qvsxjr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:55:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:55:50 INFO - Running setup.py (path:/tmp/pip-JxwWaS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:55:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:55:51 INFO - Running setup.py (path:/tmp/pip-J44De7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:55:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:55:51 INFO - Running setup.py install for manifestparser 04:55:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 04:55:51 INFO - Running setup.py install for mozcrash 04:55:51 INFO - Running setup.py install for mozdebug 04:55:51 INFO - Running setup.py install for mozdevice 04:55:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 04:55:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 04:55:51 INFO - Running setup.py install for mozfile 04:55:51 INFO - Running setup.py install for mozhttpd 04:55:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 04:55:51 INFO - Running setup.py install for mozinfo 04:55:51 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 04:55:51 INFO - Running setup.py install for mozInstall 04:55:51 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 04:55:51 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 04:55:51 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 04:55:51 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 04:55:51 INFO - Running setup.py install for mozleak 04:55:51 INFO - Running setup.py install for mozlog 04:55:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 04:55:52 INFO - Running setup.py install for moznetwork 04:55:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 04:55:52 INFO - Running setup.py install for mozprocess 04:55:52 INFO - Running setup.py install for mozprofile 04:55:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 04:55:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 04:55:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 04:55:52 INFO - Running setup.py install for mozrunner 04:55:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 04:55:52 INFO - Running setup.py install for mozscreenshot 04:55:52 INFO - Running setup.py install for moztest 04:55:52 INFO - Running setup.py install for mozversion 04:55:52 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 04:55:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:55:52 INFO - Cleaning up... 04:55:52 INFO - Return code: 0 04:55:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:55:52 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')]} 04:55:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:52 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')]} 04:55:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:52 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 0x7fa3aea94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc840>, '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 0x25396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2539b60>, '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': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', '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 04:55:52 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 04:55:52 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 04:55:52 INFO - Using env: {'DISPLAY': ':0', 04:55:52 INFO - 'HOME': '/home/cltbld', 04:55:52 INFO - 'LANG': 'en_US.UTF-8', 04:55:52 INFO - 'LANGUAGE': 'en_US:en', 04:55:52 INFO - 'LOGNAME': 'cltbld', 04:55:52 INFO - 'MAIL': '/var/mail/cltbld', 04:55:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:52 INFO - 'MOZ_NO_REMOTE': '1', 04:55:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:52 INFO - 'NO_EM_RESTART': '1', 04:55:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:52 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:52 INFO - 'SHELL': '/bin/bash', 04:55:52 INFO - 'SHLVL': '1', 04:55:52 INFO - 'TERM': 'linux', 04:55:52 INFO - 'TMOUT': '86400', 04:55:52 INFO - 'USER': 'cltbld', 04:55:52 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', 04:55:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:52 INFO - '_': '/tools/buildbot/bin/python'} 04:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:55:53 INFO - Running setup.py (path:/tmp/pip-eW0FFG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 04:55:53 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)) 04:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:55:53 INFO - Running setup.py (path:/tmp/pip-1WGNDv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 04:55:53 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)) 04:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:55:53 INFO - Running setup.py (path:/tmp/pip-_gcSi1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 04:55:53 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)) 04:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:55:53 INFO - Running setup.py (path:/tmp/pip-vHZ2Bg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 04:55:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 04:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 04:55:53 INFO - Running setup.py (path:/tmp/pip-GgeCD3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 04:55:53 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)) 04:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:55:53 INFO - Running setup.py (path:/tmp/pip-lCEmsb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 04:55:53 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)) 04:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:55:53 INFO - Running setup.py (path:/tmp/pip-vD__U9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 04:55:53 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)) 04:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:55:53 INFO - Running setup.py (path:/tmp/pip-CCYH9y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 04:55:53 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)) 04:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 04:55:53 INFO - Running setup.py (path:/tmp/pip-hUh0Aw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 04:55:53 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)) 04:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 04:55:53 INFO - Running setup.py (path:/tmp/pip-hTNU3r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 04:55:53 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)) 04:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:55:53 INFO - Running setup.py (path:/tmp/pip-TMnYZw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 04:55:53 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)) 04:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:55:53 INFO - Running setup.py (path:/tmp/pip-qe31n3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 04:55:53 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)) 04:55:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:55:53 INFO - Running setup.py (path:/tmp/pip-AJw3uo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 04:55:54 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)) 04:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:55:54 INFO - Running setup.py (path:/tmp/pip-Bol4Yg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 04:55:54 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)) 04:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:55:54 INFO - Running setup.py (path:/tmp/pip-23Ozsq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 04:55:54 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)) 04:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 04:55:54 INFO - Running setup.py (path:/tmp/pip-jCmMCo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 04:55:54 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)) 04:55:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 04:55:54 INFO - Running setup.py (path:/tmp/pip-aJ4EhY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 04:55:54 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)) 04:55:54 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)) 04:55:54 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)) 04:55:54 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)) 04:55:54 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:55:54 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 04:55:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55:56 INFO - Downloading blessings-1.5.1.tar.gz 04:55:56 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 04:55:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 04:55:56 INFO - Installing collected packages: blessings 04:55:56 INFO - Running setup.py install for blessings 04:55:56 INFO - Successfully installed blessings 04:55:56 INFO - Cleaning up... 04:55:56 INFO - Return code: 0 04:55:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 04:55:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:55:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:55:56 INFO - Reading from file tmpfile_stdout 04:55:56 INFO - Current package versions: 04:55:56 INFO - argparse == 1.2.1 04:55:56 INFO - blessings == 1.5.1 04:55:56 INFO - blobuploader == 1.2.4 04:55:56 INFO - docopt == 0.6.1 04:55:56 INFO - manifestparser == 1.1 04:55:56 INFO - mozInstall == 1.12 04:55:56 INFO - mozcrash == 0.16 04:55:56 INFO - mozdebug == 0.1 04:55:56 INFO - mozdevice == 0.47 04:55:56 INFO - mozfile == 1.2 04:55:56 INFO - mozhttpd == 0.7 04:55:56 INFO - mozinfo == 0.9 04:55:56 INFO - mozleak == 0.1 04:55:56 INFO - mozlog == 3.1 04:55:56 INFO - moznetwork == 0.27 04:55:56 INFO - mozprocess == 0.22 04:55:56 INFO - mozprofile == 0.28 04:55:56 INFO - mozrunner == 6.11 04:55:56 INFO - mozscreenshot == 0.1 04:55:56 INFO - mozsystemmonitor == 0.0 04:55:56 INFO - moztest == 0.7 04:55:56 INFO - mozversion == 1.4 04:55:56 INFO - psutil == 3.1.1 04:55:56 INFO - requests == 1.2.3 04:55:56 INFO - wsgiref == 0.1.2 04:55:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 04:55:56 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')]} 04:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:56 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')]} 04:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:56 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 0x7fa3aea94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc840>, '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 0x25396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2539b60>, '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': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', '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 04:55:56 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 04:55:56 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 04:55:56 INFO - Using env: {'DISPLAY': ':0', 04:55:56 INFO - 'HOME': '/home/cltbld', 04:55:56 INFO - 'LANG': 'en_US.UTF-8', 04:55:56 INFO - 'LANGUAGE': 'en_US:en', 04:55:56 INFO - 'LOGNAME': 'cltbld', 04:55:56 INFO - 'MAIL': '/var/mail/cltbld', 04:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:56 INFO - 'MOZ_NO_REMOTE': '1', 04:55:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:56 INFO - 'NO_EM_RESTART': '1', 04:55:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:56 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:56 INFO - 'SHELL': '/bin/bash', 04:55:56 INFO - 'SHLVL': '1', 04:55:56 INFO - 'TERM': 'linux', 04:55:56 INFO - 'TMOUT': '86400', 04:55:56 INFO - 'USER': 'cltbld', 04:55:56 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', 04:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:56 INFO - '_': '/tools/buildbot/bin/python'} 04:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:56 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)) 04:55:56 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)) 04:55:56 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)) 04:55:56 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)) 04:55:56 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)) 04:55:56 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)) 04:55:56 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)) 04:55:56 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)) 04:55:56 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)) 04:55:56 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)) 04:55:56 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)) 04:55:56 INFO - Cleaning up... 04:55:56 INFO - Return code: 0 04:55:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 04:55:56 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')]} 04:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:56 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')]} 04:55:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:56 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 0x7fa3aea94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc840>, '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 0x25396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2539b60>, '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': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', '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 04:55:56 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 04:55:56 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 04:55:56 INFO - Using env: {'DISPLAY': ':0', 04:55:56 INFO - 'HOME': '/home/cltbld', 04:55:56 INFO - 'LANG': 'en_US.UTF-8', 04:55:56 INFO - 'LANGUAGE': 'en_US:en', 04:55:56 INFO - 'LOGNAME': 'cltbld', 04:55:56 INFO - 'MAIL': '/var/mail/cltbld', 04:55:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:56 INFO - 'MOZ_NO_REMOTE': '1', 04:55:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:56 INFO - 'NO_EM_RESTART': '1', 04:55:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:56 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:56 INFO - 'SHELL': '/bin/bash', 04:55:56 INFO - 'SHLVL': '1', 04:55:56 INFO - 'TERM': 'linux', 04:55:56 INFO - 'TMOUT': '86400', 04:55:56 INFO - 'USER': 'cltbld', 04:55:56 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', 04:55:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:56 INFO - '_': '/tools/buildbot/bin/python'} 04:55:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:56 INFO - Downloading/unpacking jsonschema 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55: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 04:55:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:55:58 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 04:55:58 INFO - Downloading/unpacking functools32 (from jsonschema) 04:55:58 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 04:55:58 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 04:55:58 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 04:55:58 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 04:55:58 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 04:55:58 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 04:55:58 INFO - Downloading functools32-3.2.3-2.tar.gz 04:55:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:55:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 04:55:58 INFO - warning: no files found matching '*.txt' 04:55:58 INFO - no previously-included directories found matching 'build' 04:55:58 INFO - no previously-included directories found matching 'dist' 04:55:58 INFO - no previously-included directories found matching '.git*' 04:55:58 INFO - Installing collected packages: jsonschema, functools32 04:55:58 INFO - Running setup.py install for functools32 04:55:58 INFO - warning: no files found matching '*.txt' 04:55:58 INFO - no previously-included directories found matching 'build' 04:55:58 INFO - no previously-included directories found matching 'dist' 04:55:58 INFO - no previously-included directories found matching '.git*' 04:55:58 INFO - Successfully installed jsonschema functools32 04:55:58 INFO - Cleaning up... 04:55:59 INFO - Return code: 0 04:55:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 04:55:59 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')]} 04:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:59 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')]} 04:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:55:59 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 0x7fa3aea94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253b630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cc840>, '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 0x25396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2539b60>, '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': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', '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 04:55:59 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 04:55:59 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 04:55:59 INFO - Using env: {'DISPLAY': ':0', 04:55:59 INFO - 'HOME': '/home/cltbld', 04:55:59 INFO - 'LANG': 'en_US.UTF-8', 04:55:59 INFO - 'LANGUAGE': 'en_US:en', 04:55:59 INFO - 'LOGNAME': 'cltbld', 04:55:59 INFO - 'MAIL': '/var/mail/cltbld', 04:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:55:59 INFO - 'MOZ_NO_REMOTE': '1', 04:55:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:55:59 INFO - 'NO_EM_RESTART': '1', 04:55:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:55:59 INFO - 'PWD': '/builds/slave/test-pgo', 04:55:59 INFO - 'SHELL': '/bin/bash', 04:55:59 INFO - 'SHLVL': '1', 04:55:59 INFO - 'TERM': 'linux', 04:55:59 INFO - 'TMOUT': '86400', 04:55:59 INFO - 'USER': 'cltbld', 04:55:59 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', 04:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:55:59 INFO - '_': '/tools/buildbot/bin/python'} 04:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:55:59 INFO - Downloading/unpacking flake8 04:55:59 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 04:55:59 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 04:55:59 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 04:55:59 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 04:55:59 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 04:55:59 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 04:56:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:56:00 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 04:56:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:56:00 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 04:56:00 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 04:56:00 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 04:56:00 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 04:56:00 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 04:56:00 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 04:56:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:56:01 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 04:56:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:56:01 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 04:56:01 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 04:56:01 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 04:56:01 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 04:56:01 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 04:56:01 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 04:56:01 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 04:56:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:56:01 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 04:56:01 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 04:56:01 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 04:56:01 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 04:56:01 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 04:56:01 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 04:56:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:56:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 04:56:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:56:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:56:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:56:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:56:01 INFO - no previously-included directories found matching 'docs/_build' 04:56:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:56:01 INFO - Running setup.py install for pep8 04:56:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:56:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:56:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:56:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:56:01 INFO - no previously-included directories found matching 'docs/_build' 04:56:01 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 04:56:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:56:01 INFO - Cleaning up... 04:56:01 INFO - Return code: 0 04:56:01 INFO - Running post-action listener: _resource_record_post_action 04:56:01 INFO - Running post-action listener: _start_resource_monitoring 04:56:01 INFO - Starting resource monitoring. 04:56:01 INFO - ##### 04:56:01 INFO - ##### Running install step. 04:56:01 INFO - ##### 04:56:01 INFO - Running pre-action listener: _resource_record_pre_action 04:56:01 INFO - Running main action method: install 04:56:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 04:56:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 04:56:02 INFO - Reading from file tmpfile_stdout 04:56:02 INFO - Detecting whether we're running mozinstall >=1.0... 04:56:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 04:56:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 04:56:02 INFO - Reading from file tmpfile_stdout 04:56:02 INFO - Output received: 04:56:02 INFO - Usage: mozinstall [options] installer 04:56:02 INFO - Options: 04:56:02 INFO - -h, --help show this help message and exit 04:56:02 INFO - -d DEST, --destination=DEST 04:56:02 INFO - Directory to install application into. [default: 04:56:02 INFO - "/builds/slave/test-pgo"] 04:56:02 INFO - --app=APP Application being installed. [default: firefox] 04:56:02 INFO - mkdir: /builds/slave/test-pgo/build/application 04:56:02 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'] 04:56:02 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 04:56:17 INFO - Reading from file tmpfile_stdout 04:56:17 INFO - Output received: 04:56:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 04:56:17 INFO - Running post-action listener: _resource_record_post_action 04:56:17 INFO - ##### 04:56:17 INFO - ##### Running run-tests step. 04:56:17 INFO - ##### 04:56:17 INFO - Running pre-action listener: _resource_record_pre_action 04:56:17 INFO - Running main action method: run_tests 04:56:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 04:56:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 04:56:17 INFO - Python 2.7.3 04:56:17 INFO - Return code: 0 04:56:17 INFO - grabbing minidump binary from tooltool 04:56: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')]} 04:56:17 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 0x25cc840>, '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 0x25396b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2539b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 04:56:17 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 04:56:17 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 04:56:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:56:17 INFO - Return code: 0 04:56:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 04:56:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 04:56:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 04:56:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 04:56:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 04:56:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 04:56:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 04:56:18 INFO - Return code: 0 04:56:18 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 04:56:18 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 04:56:18 INFO - Using env: {'DISPLAY': ':0', 04:56:18 INFO - 'HOME': '/home/cltbld', 04:56:18 INFO - 'LANG': 'en_US.UTF-8', 04:56:18 INFO - 'LANGUAGE': 'en_US:en', 04:56:18 INFO - 'LOGNAME': 'cltbld', 04:56:18 INFO - 'MAIL': '/var/mail/cltbld', 04:56:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:56:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 04:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:56:18 INFO - 'MOZ_NO_REMOTE': '1', 04:56:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 04:56:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:56:18 INFO - 'NO_EM_RESTART': '1', 04:56:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 04:56:18 INFO - 'PWD': '/builds/slave/test-pgo', 04:56:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 04:56:18 INFO - 'SHELL': '/bin/bash', 04:56:18 INFO - 'SHLVL': '1', 04:56:18 INFO - 'TERM': 'linux', 04:56:18 INFO - 'TMOUT': '86400', 04:56:18 INFO - 'USER': 'cltbld', 04:56:18 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173', 04:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:56:18 INFO - '_': '/tools/buildbot/bin/python'} 04:56:18 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:56:19 INFO - mozversion application_buildid: 20160104023003 04:56:19 INFO - mozversion application_changeset: 8060449a6dd05e89690e957c1e88230c6ff6e1d4 04:56:19 INFO - mozversion application_display_name: Nightly 04:56:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:56:19 INFO - mozversion application_name: Firefox 04:56:19 INFO - mozversion application_remotingname: firefox 04:56:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:56:19 INFO - mozversion application_vendor: Mozilla 04:56:19 INFO - mozversion application_version: 46.0a1 04:56:19 INFO - mozversion platform_buildid: 20160104023003 04:56:19 INFO - mozversion platform_changeset: 8060449a6dd05e89690e957c1e88230c6ff6e1d4 04:56:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:56:19 INFO - mozversion platform_version: 46.0a1 04:56:19 INFO - using testdate: 1451912179 04:56:19 INFO - actual date: 1451912179 04:56:19 INFO - starting webserver on 'localhost:59443' 04:56:19 INFO - SUITE-START | Running 3 tests 04:56:19 INFO - TEST-START | dromaeo_css 04:56:19 INFO - operating with platform_type : linux_ 04:56:19 INFO - Initialising browser for dromaeo_css test... 04:56:19 INFO - TEST-INFO | started process 6497 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_fZDQI/profile http://localhost:59443/getInfo.html) 04:56:23 INFO - PROCESS | 6497 | __metrics Screen width/height:1600/1200 04:56:23 INFO - PROCESS | 6497 | colorDepth:24 04:56:23 INFO - PROCESS | 6497 | Browser inner width/height: 1024/697 04:56:23 INFO - PROCESS | 6497 | __metrics 04:56:23 INFO - PROCESS | 6497 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:56:23 INFO - PROCESS | 6497 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:56:24 INFO - TEST-INFO | 6497: exit 0 04:56:24 INFO - Browser initialized. 04:56:24 INFO - Running cycle 1/1 for dromaeo_css test... 04:56:24 INFO - TEST-INFO | started process 6592 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_fZDQI/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:36 INFO - PROCESS | 6592 | RSS: Main: 150306816 04:56:36 INFO - PROCESS | 6592 | 04:57:27 INFO - PROCESS | 6592 | 1451912247963 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] 04:59:36 INFO - PROCESS | 6592 | Cycle 1(1): loaded http://localhost:59443/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59443/tests/dromaeo/cssquery-ext.html) 04:59:37 INFO - PROCESS | 6592 | RSS: Main: 277180416 04:59:37 INFO - PROCESS | 6592 | 05:02:40 INFO - PROCESS | 6592 | Cycle 1(1): loaded http://localhost:59443/tests/dromaeo/cssquery-ext.html (next: http://localhost:59443/tests/dromaeo/cssquery-jquery.html) 05:02:40 INFO - PROCESS | 6592 | RSS: Main: 235495424 05:02:40 INFO - PROCESS | 6592 | 05:05:42 INFO - PROCESS | 6592 | Cycle 1(1): loaded http://localhost:59443/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59443/tests/dromaeo/cssquery-mootools.html) 05:05:43 INFO - PROCESS | 6592 | RSS: Main: 226795520 05:05:43 INFO - PROCESS | 6592 | 05:08:45 INFO - PROCESS | 6592 | Cycle 1(1): loaded http://localhost:59443/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59443/tests/dromaeo/cssquery-prototype.html) 05:08:45 INFO - PROCESS | 6592 | RSS: Main: 215769088 05:08:45 INFO - PROCESS | 6592 | 05:11:48 INFO - PROCESS | 6592 | Cycle 1(1): loaded http://localhost:59443/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59443/tests/dromaeo/cssquery-yui.html) 05:11:48 INFO - PROCESS | 6592 | RSS: Main: 219865088 05:11:48 INFO - PROCESS | 6592 | 05:14:51 INFO - PROCESS | 6592 | Cycle 1(1): loaded http://localhost:59443/tests/dromaeo/cssquery-yui.html (next: http://localhost:59443/tests/dromaeo/cssquery-dojo.html) 05:14:51 INFO - PROCESS | 6592 | RSS: Main: 277188608 05:14:51 INFO - PROCESS | 6592 | 05:14:51 INFO - PROCESS | 6592 | __start_tp_report 05:14:51 INFO - PROCESS | 6592 | _x_x_mozilla_page_load 05:14:51 INFO - PROCESS | 6592 | _x_x_mozilla_page_load_details 05:14:51 INFO - PROCESS | 6592 | |i|pagename|runs| 05:14:51 INFO - PROCESS | 6592 | |0;dojo.html;3035.8785648574058;3139.419207446621;3148.370325934811;3155.873765049398;3189.6331921828996;5087.414947281064;5220.216967454884;5224.869378265541;5241.240020197074;5283.762230699618;5274.841754747364;5314.601404894639;5383.703896285702;5389.51494365507;5393.325834270716;4752.192127338343;4793.9520604794025;4846.273059041137;4864.124457597631;4893.4372547157;4831.202851529511;4835.178019736635;4851.22380419133;4904.264360345959;4942.308076869242;4702.153612349775;4716.551927566876;4782.450018247911;4821.903561928777;4861.392325959255;4788.664793464459;4790.688605240648;4803.03939212159;4830.5652491275605;4838.854834354975;4676.438827340707;4797.904041919177;4813.951860481386;4816.060868130716;4829.517048295177;5044.218146187347;5063;5136.357955255593;5161.5870730341485;5245.160774276135;5577.972110139464;5583.3300003999375;5586.329640443132;5588.524975377098;5599.132134519156;5552.944470555283;5597.384287728347;5629.071203251499;5652.74562644682;5736.053551164053;5237.528622423962;5257.921131183035;5345.572354211654;5357.1696387060065;5364.114921037985;5807.535397168216;5811.215485909348;5814.098814683731;5817.476427121494;5864.824055278348;5603.579731520153;5604;5614.606977511617;5616.634918730269;5617.550595952314;5501.614886957875;5571.860703482445;5589.217509548666;5679.318481782213;5728.169415434739;5638.85902852432;5652.547796176296;5667.4615911488345;5673.716314184357;5675.120356344773;5473.644213126134;5652.208690783294;5671.9716401418555;5673.716314184274;5675.971620141955;4338.956610433918;4392.4289842320295;4457.286834106528;4461.263891457873;4495.325701144854;3865.8840234792438;3870.8838734838;3878.398848178537;3883.456316115746;3918.6081391861157;5093.414257360451;5189.818356357509;5205.713685747321;5205.9739701302005;5249.291345668362;5511.22842802008;5623.044082505984;5642.181883626851;5645.2096706461125;5697.145428185722;5229.555487783581;5235.554977826851;5239.895202095937;5246.0557099721655;5280.9438112377675;4732.881677958078;4803.951960480351;4823.662343635911;4830.033993201374;4841.515848415131;5788.9290481261105;5908.14331921869;5930.377310382434;5938.079597662369;5982.820515384546;5583.944160558342;5620.85947851307;5635.464630860061;5636.436356364331;5638.351589567088;5571.637843540157;5874.236349274567;5882.617629854046;5885.823425297248;5889.469947704727;5489.917651235155;5495.725213739377;5510.1459273812625;5560.777568897199;5566.276384070045;5607.383187849415;5613.1860880171325;5614.326280846161;5622.128570071645;5622.381538030895;5374.140137577969;5483.561315094703;5495.780168793203;5496.395396506461;5546.639468434539;5400.864978375572;5465.426130256265;5471.452854714656;5500.7524661391135;5540.335159780852;5478.178273259043;5483.670979741229;5486.204500347348;5488.259085023471;5503.642263253036;5418.864528386822;5573.331200255995;5592.049351610155;5613.214150018919;5619.80330688424;5311.362636483646;5318.946810531846;5395.568354531707;5398.2712333836;5404.83785486436 05:14:51 INFO - PROCESS | 6592 | |1;ext.html;525.2174260352075;535.0449447735792;538.644494633542;553.5820455556055;563.5097465205272;28957.710422895765;29528.261793455174;35920.101997450045;36859.447108293396;37072.44391334125;39132.60867391325;39511.60488395115;39537.802310988474;39598.604013959855;39605.40591891124;7265.055542779432;8403.83192336153;8568.78578035551;8570.87143692842;8581.141885811432;7388.667509962064;7485.214052524489;10033.448160351178;10293.53679084443;10306.433146176958;10047.598096076148;10169.389836609827;10176.08415242628;10177.898221017806;10181.898181018207;10022.24833137514;10077.344972576759;10083;10123.79752404955;10124.848127278097;9811.656592019244;9907.207423406111;9927.453990030546;9942.80114397708;9946.20430365569;36563;37099.25801483982;39864.800675996725;39900;40328.59671403278;3183.602049743782;3247.269364393016;3284.113289411869;3361.7142542883885;3524.4360902255517;28824.567631485545;30257.394852102836;30275.545866812015;30582.388352233054;31299.84350078235;3857.517810273716;3892.552356479013;3961.6772427522706;3997.8001099945177;4049.6760259179196;273065;273667;273683;274317.51364972786;275267;50674;51651.48348516467;51651.96696066133;55725.721371393694;56201.43798562044;46253.537464624926;59437.70281148653;60481.39518604758;61256.38743612596;61356.38643613596;12223.816642750366;12246.877531224753;12297.692557686129;12335.629931101901;12391.62825115248;10048.59805607782;10567.94716026415;11184.44077796107;11328.603498877665;11336.489857956412;18580.163892624863;19121.808781912;19148.904255478632;19232.134553945107;19238.422847314603;7353.6323183840595;7545.50954187976;7676.846463070708;7697.461177717506;7729.690812367555;871.2942516561606;950.2777888804559;1027.8355463126013;1033.9896601034043;1042.854000439939;28052.29869253285;28463.146105616866;28549;29149.125526234246;29281.853590732335;998.0468652436905;1013.6452241715341;1032.1278519650882;1036.2538971940191;1093.0981939899455;13220;13281.601551953458;13351.799723004162;13413;13416.932915335556;256645;261025;261411;261908;261985;46886;47080.29379559309;47214.763926180836;47321;47389.052218955425;1323.5367621332457;1336.1582203212108;1338.1302153600043;1351.250056218808;1363.1957145284132;24919.626205606568;25890.22329330123;26052.478950421264;26118.216453506426;26147.869260653573;42061.36907946322;42297.788511058476;42327.78836105923;42336;42370.78814605907;295794;296777;299473;299552;299981;26018.73981260163;29537.704622953497;31012.22469438282;31149.377012460078;31219.37561248717;35860.82069589636;36393;36492.270154596226;36786.26427471382;36947.44578831374;31729.8413507931;31745.5238171423;31891.36217275688;32231.838840805645;32481.837590811894;31775.616828737475;31939.840300798347;32140.517892232103;33408.1647958803;35147.82426087853;31106.533401998535;31432.68567314389;34745;35333.823330883184;35682.64317356897;28625;31385.215369615944;31879;31934.84032579822;32050.67949320477;23758.643620345363;23993.640095398932;24169.39576510531;24395.39011524726;24724.752752472963 05:14:51 INFO - PROCESS | 6592 | |2;jquery.html;353.094313086932;354.7534463547834;356.8198059979712;356.86617518430586;357.25690563627654;13617.387217575208;13777.44890204393;16508.752368714464;17346.30614775409;18523.351682691107;15822.920885395586;16417.425390111348;16625.50123496294;16983.405580804676;17019;5350.438203988583;5496.1755736639625;5506.64206826557;5536.612437129403;5543.722813859311;4060.1473690525027;4194.853180138696;5514.338279406476;5552.805651802188;5992.940070599304;6018.097285407202;6024.879502409949;6058;6060.727267272983;6094.939050609503;5078.238264260372;5216.26972223889;5221.660592061504;5232.136697444936;6041.154238406627;4976.4277108132665;5012.72430016349;5016.046951079284;5028.522290382408;5271.604629652791;11857.703557411047;12202.755944881053;12446;12469.75060498785;12492.312922789242;1992.870463419873;2019.545602239499;2022.6662600670873;2045.92839250627;2184.530325979906;9177.265818734486;9391.953040234755;9580.89220371524;11149.554017839277;12686.111972161953;1741.930322787087;1802;1837.4395809278165;1837.5222442165;1922.8173323534243;59738.402615974155;63022.684886575735;63552.68223658898;64248.67875660592;64561.354386456005;9334.7178816411;9353.129374125203;9414.905850941539;9453.480058596706;9587.376820506644;12169.391530423443;12197.878021219674;12204.32876191818;12206.572769953009;12212.267263964191;6863.352795329185;6899.931000689929;6906.309369063154;6917.861642767217;7162.4628152888745;6655.134832471747;6716.3955244028275;7012.474064445187;7220.963895180491;7330.120385553768;3942.9802850986134;3991.4212439196153;3994.9201015979515;4022.3162062449455;4037.2127435149864;1576.65313631001;1622.3186261770086;1647.4645740134504;1656.2215758593443;1697.125980120239;428.8220388538784;432.11416595978744;442.76975972494125;478.42827820753865;904.2547882586671;10504.632337868137;10568.894311056945;10702.197335199735;10736.838947415796;10819.350838949687;450.9842155524606;452.75098695717224;459.228496126504;463.59898687635626;486.10071367968976;5838.38696936824;5896.380880007623;5979.790707325223;5993.760249589967;6033.637981721111;510207;517782;551649;557447;562512;78936.6053169742;79662.6016869912;80648.59675701584;80715.59642201751;81061.59469202734;488.45049319515545;492.4804331430447;494.1944630252665;494.9133901567283;495.46242327074805;9975.152112070555;10179.185665146919;10213.591456341663;10257.897421025695;10378.325408848401;31473.21316967094;33217.335653287286;33695.494567582;34019;34039.31921361509;38573;42228;42806.571934280255;43032.56967430285;45231.09537809291;9229.630814767334;9522.23822094217;9686.612535498502;9728.221742260745;9778.853317200106;11193.27243729155;11281.32312061279;15518.612034699223;16874.463883181117;18070.909645451688;11743.588974385855;11874.82187767167;12838;14051.086679365808;14354.425822967381;13468.19190848513;13745.320221633983;13905.026648134533;13958;14396.640083997983;13969.860301397262;13993.650158746113;14107.083039602803;14192.36134373935;14282.71434571282;9211.76970575741;9272.258219342571;9331.766705832408;9388.202002829563;9464.337496375188;10149.086582207638;10277.486125693536;13153.342332883509;14239.715205696035;14633.414663413345 05:14:51 INFO - PROCESS | 6592 | |3;mootools.html;1282.5254655777364;1389.5275606293858;1394.31678477546;1484.5249520153548;1716.1848122141992;6577.70400331985;7210.675519601617;7348.485606007568;7349.228331025232;7356.301151390609;7118.644067796616;7280.745173918914;7293.890591641117;7297.635118244079;7308.890366644491;1963.6072785442898;2003.24878170686;2226.3988723044768;2240.764719704436;2278.6695929090274;2282.6347784354507;2285.0402830811017;2303.7120359955006;2307.3308740465327;2313.201945328859;2173.9782602174014;2281.349815302639;2281.543691261746;2286.5769832581027;2287.3595393289906;2240.19353032908;2241.540484200735;2256.740474845389;2279.954400911989;2282.5206706591634;2255.7180352455944;2276.8520046196945;2282.794548490627;2324.4305145239355;2325.267540724666;7306.890396644055;7477.10274767026;7477.962610186914;7481;7492.475526713132;4518.2319005769095;4596.885077873047;4625.121226966866;4630.166570017395;4634.189016922059;2940.8235505869716;3001.3096987692734;3031.4543382191196;3040.0423866481988;3084.33686757346;995.9053889880449;1011.4942528735633;1035.7048241251282;1049.5329578337644;1077.0952399983973;10105.343152695052;10182.9490852546;10187.388756674549;10189.54147063384;10198.43908585035;4119.588041195916;4172.72877262983;4182.121754431542;4266.658667306608;4268.637165840876;8753.91246087531;8762.342824288204;8771.16673915977;8772.868406973901;8781.648734050694;4689.20283551797;4689.554492323224;4706.976465117721;4722.338872557844;4724.834630787975;4209.158168366339;4236.491621005499;4237.851675191415;4285.292926667127;4286.314189729628;3314.5691060162026;3360.4119279126057;3517.402041652925;3519.8912342611993;3554.147004718849;1098.758273179899;1114.570890207276;1118.4184224203368;1120.7030137013699;1121.960731374398;1077.1867240233573;1248.182440501473;1267.9619611411672;1269.8666640002853;1270.5997610752584;6792.42264407521;6841.863162736718;6845.726170953206;6846.178458585002;6849.554778939353;961.403929563675;962.6678795815433;990.9990909181778;1029.7837454134715;1062.990159348622;5492.395836457987;5594;5600.551955843523;5619.690916999522;5622.971885140548;9043.457392556467;9049.276057915351;9072.727818165466;9085.727428177166;9359.391639543408;8834.734957951272;9210.539473026322;9252.49111298885;9253.537323133816;9281.535923203814;6743.831404214836;6869.519133660596;6899.310068993061;6963.09479767627;7048.506604537633;6789.1852977643;6835.111435513351;6835.69239384219;6837.35045170708;6838.418734407631;7770.533767973713;7829.921700782919;7844.176361481962;7845.293923546908;7869.409794265567;7835.216478352348;7973.401994850294;8022.91977080245;8104.108548059591;8151.429399942184;6438.130852335063;6506.642134682638;6562.5406221564035;6573.04690819838;6589.604623722592;6500.674966251574;6562.114114594468;6883.346082122191;7047.154341479055;7049.013138160764;6463.64449955257;6637.900431493628;6694.966525167343;6752.729890804313;6780.288069752605;6380.202474690664;6405.8398540035005;6451.935480645134;6487.702459508023;6540.640264785482;6348.650824204713;6422.967885160544;6431.871362572816;6432.388923052303;6437.195350581177;5937;5950.077737950624;5962.761489540369;5974.193483879794;5978.491828194652;6210.782622608368;6239.06414037898;6272.968635156795;6276.089966954857;6285.120083188266 05:14:51 INFO - PROCESS | 6592 | |4;prototype.html;336.7003367003367;340.1411436123787;344.85171376308176;347.51868661903256;353.2475826489577;5831.766729330827;5890.941090589093;5891.086881533359;5903.970480147598;5948.375420580842;5631.352394474627;5681.375048744645;5758.568107391952;5812.273465816773;5877.441643043915;4568.040711450582;4571.588557029867;4571.588557029867;4574.268117101273;4582.839600613979;4334.479862416514;4568.497465278817;4572.222722137245;4577.382053422795;4577.862664120065;4378.605925466707;4403.801828917706;4496.9775151124195;4520.841770538032;4524.660650451213;4481.081378317437;4483.08096840147;4501.212287849613;4501.302298143776;4511.751853648048;3984.183242435323;3989;3989.1024519483176;3998.5601583825755;4000.2799496090693;5458.6724796512335;5547.916781248285;5556.749946252428;5557.944420555783;5562.610617256793;5271.578273738091;5285.048691235576;5292.470752924715;5296.179092240709;5299.54953828925;6209.627422354673;6218.657973811439;6219.440250377443;6220.720067596923;6222.408871157233;4418.955810441887;4422.469303683579;4423.845165419227;4426.203283408985;4427.933580996288;6313.400226978476;6465.709043093072;6482.092507049017;6496.123023391876;6497.610143391459;4551.431071116044;4552.499225085238;4556.863294101182;4557.316402539645;4560.703554269028;4619.95380046202;4626.167289887785;4626.653001024936;4627.838025669085;4628.4445866496235;5293.047251494768;5311.070562651521;5334.7065911374475;5339.679619222781;5347.224652425377;6135;6258.812235632939;6277.843053923597;6278.591891527036;6287.842803929939;1612.137506434052;1625.4310991153002;1631.4942367866;1634.2727486268734;1634.3789360043345;1114.5987444519967;1120.6806060272784;1121.7195701074731;1123.0678536814423;1151.113642495274;5902.58681892272;5918.940810591925;5919.467247947706;5932.406759324033;5938.406159384027;6416.711247993851;6417.326180751047;6427.871442571122;6431.614103153825;6437.2918978912285;5785.958527465013;5786.537077033827;5886.911696324559;6002.759889604455;6014.0678194879865;3462.082548124749;3475.8435870385892;3477.0264325988765;3487.9476807847905;3489.616142224353;6683.6658167091455;6691.364320389555;6692.6988285526295;6693.1298931138645;6702.597844129368;6438.420542151229;6587.934120658732;6647.268800431949;6667.299933507009;6678.933210667831;6764.830879228059;6817.5227734059135;6822.317768223138;6826.317368263134;6835.521513494107;6513.641749703812;6513.73945042193;6514.967425163033;6518.934810651833;6524.3149469305035;6319;6426.29310775805;6426.389492998158;6456.6771661415805;6462.935370646422;6801.693923773343;6817.863642727217;6819.318068193141;6828.044073829568;6829.351211634887;4464.955350446584;4491.550844915482;4491.955080449154;4499.30260809562;4502.909941801211;6430.164078669743;6538.705758240986;6540.640264785482;6551.344865513411;6554.787364337612;6307.180066591313;6333.36666333363;6335.556511044183;6337.7148028337915;6371.776987805404;6341.968290158519;6346.2067241594805;6350.206224221973;6354.936450635434;6358.141650877257;6025.1564780931585;6211.161493198541;6235.563510554218;6238.6880655967925;6248.468880145057;6392.169018027626;6395.840103997437;6404.775832845828;6405.551611387158;6405.583637063576;6165.445109940127;6246.5002799775;6247;6253.405926436982;6253.937460625518 05:14:51 INFO - PROCESS | 6592 | |5;yui.html;692.4460431654677;799.3485309472776;800.8438354520869;808.6684459371659;813.4590497319283;11415.42922853857;11455.427228638577;11721;11765.529378824858;11790.646280611574;12125.333106679129;12161.270323780558;12175.756484870297;12190.329531875765;12208.389580520983;668.5921587831443;680.0852852912824;793.436659971421;807.9313258373016;809.2029351089172;802.314021511608;811.6793866422789;818.7789296889836;819.1276290750361;819.3608984991686;826.4793180296405;835.5488036460304;840.8066144786703;841.2344766262702;841.9031811341682;679.8470344172547;688.528358074718;830.5722552885269;838.8909441772591;857.275602116217;624.0794827629256;625.7590827531433;629.062696582094;629.131798118598;629.3046183966742;12866.228026318357;12979.935100324437;13056.738865222642;13064.86935130646;13076.542321018718;11186.944065279702;11730.882691173065;11752.177347585672;11815.704607384798;12133.150679452441;10580.576776928914;10593.36439813606;10596.841047384296;10702.304350217211;10738.677839664822;3554.9111272218142;3603.387424137903;3620.529331186955;3644.344018076745;3723.1064544509395;46229.537704623195;46336.53663463356;46544;46605.76697116526;46651.30023049657;8232.794180145544;8588.570571471402;9015.504147271831;9071.138241867013;9208.309376796768;17662.823371766375;17678.734818977726;17704.38034668806;17732.468025959242;17742.645147096984;7021;7125;7142.392896603847;7197.640117994079;7527.661255243527;3917.7845218512684;3927.5286965564314;3976.58245884178;4016.096378314856;4027.335489644176;2960.7779416543412;2981.001364542859;2986.566947792558;2989.327401334726;2998.7151220634005;486.95860851827285;488.57982135363557;495.8289390160389;508.98982020359387;517.6945602094706;527.0965189873433;555.9082751345983;636.9140166077613;638.8562573420943;659.2023651381786;8424.283935865398;8497.957510212409;8709.433886797338;8839.381243312906;8855.867161992575;552.3316786688072;558.7653185662032;612.953620506084;638.4286063972719;712.4229374206909;3777.244551089793;4214.325707886785;4352.586504282088;4404.493483249404;4423.933640995388;60333;60714.696426517585;60836;60880.695596521735;60896.39103608996;45876.311855322194;46221;46249;46819.29771053437;48726;42155.789221053696;45591.31613025807;46533;46843.531564683915;47086.76456617695;8062.83874322522;8078.111407745261;8496.1079086695;8761.693340733298;8912.33157513176;34657.306853862276;34795;34863.65136348604;35657.82171089128;35830;43119.56880431156;45850.54149458596;46824.297635536175;47114;47597;9829.899735621233;10332.91504392028;10340.586376544854;10352.844707329547;10528.315659482108;10819.404932728776;10965;10989.395583242678;11039.889601103887;12313.56902508408;10696.518656660313;11274.154438416988;11875.168738188244;11910.642680719593;12223.87776122263;11600.88399115998;11602.825957610474;11764.58823941158;11983.041356691618;12193.451294691582;11713.88286117128;11751.412429378326;11974.521019159136;12175;12332.753344933231;8698.826023479622;8857.424267422597;8864;9006.414583052081;9100.408473449204;8530.360222983178;9140.588673509841;9358.344915856098;9548.70652308454;10024.799504010025 05:14:51 INFO - PROCESS | 6592 | __end_tp_report 05:14:51 INFO - PROCESS | 6592 | __start_cc_report 05:14:51 INFO - PROCESS | 6592 | _x_x_mozilla_cycle_collect,994 05:14:51 INFO - PROCESS | 6592 | __end_cc_report 05:14:51 INFO - PROCESS | 6592 | __startTimestamp1451913291420__endTimestamp 05:14:51 INFO - PROCESS | 6592 | 05:14:51 INFO - PROCESS | 6592 | ------- Summary: start ------- 05:14:51 INFO - PROCESS | 6592 | Number of tests: 6 05:14:51 INFO - PROCESS | 6592 | 05:14:51 INFO - PROCESS | 6592 | [#0] dojo.html Cycles:165 Average:5236.97 Median:5418.86 stddev:578.40 (10.7%) stddev-sans-first:553.80 05:14:51 INFO - PROCESS | 6592 | Values: 3035.9 3139.4 3148.4 3155.9 3189.6 5087.4 5220.2 5224.9 5241.2 5283.8 5274.8 5314.6 5383.7 5389.5 5393.3 4752.2 4794.0 4846.3 4864.1 4893.4 4831.2 4835.2 4851.2 4904.3 4942.3 4702.2 4716.6 4782.5 4821.9 4861.4 4788.7 4790.7 4803.0 4830.6 4838.9 4676.4 4797.9 4814.0 4816.1 4829.5 5044.2 5063.0 5136.4 5161.6 5245.2 5578.0 5583.3 5586.3 5588.5 5599.1 5552.9 5597.4 5629.1 5652.7 5736.1 5237.5 5257.9 5345.6 5357.2 5364.1 5807.5 5811.2 5814.1 5817.5 5864.8 5603.6 5604.0 5614.6 5616.6 5617.6 5501.6 5571.9 5589.2 5679.3 5728.2 5638.9 5652.5 5667.5 5673.7 5675.1 5473.6 5652.2 5672.0 5673.7 5676.0 4339.0 4392.4 4457.3 4461.3 4495.3 3865.9 3870.9 3878.4 3883.5 3918.6 5093.4 5189.8 5205.7 5206.0 5249.3 5511.2 5623.0 5642.2 5645.2 5697.1 5229.6 5235.6 5239.9 5246.1 5280.9 4732.9 4804.0 4823.7 4830.0 4841.5 5788.9 5908.1 5930.4 5938.1 5982.8 5583.9 5620.9 5635.5 5636.4 5638.4 5571.6 5874.2 5882.6 5885.8 5889.5 5489.9 5495.7 5510.1 5560.8 5566.3 5607.4 5613.2 5614.3 5622.1 5622.4 5374.1 5483.6 5495.8 5496.4 5546.6 5400.9 5465.4 5471.5 5500.8 5540.3 5478.2 5483.7 5486.2 5488.3 5503.6 5418.9 5573.3 5592.0 5613.2 5619.8 5311.4 5318.9 5395.6 5398.3 5404.8 05:14:51 INFO - PROCESS | 6592 | 05:14:51 INFO - PROCESS | 6592 | [#1] ext.html Cycles:180 Average:43669.28 Median:31581.26 stddev:72572.39 (229.8%) stddev-sans-first:72703.67 05:14:51 INFO - PROCESS | 6592 | Values: 525.2 535.0 538.6 553.6 563.5 28957.7 29528.3 35920.1 36859.4 37072.4 39132.6 39511.6 39537.8 39598.6 39605.4 7265.1 8403.8 8568.8 8570.9 8581.1 7388.7 7485.2 10033.4 10293.5 10306.4 10047.6 10169.4 10176.1 10177.9 10181.9 10022.2 10077.3 10083.0 10123.8 10124.8 9811.7 9907.2 9927.5 9942.8 9946.2 36563.0 37099.3 39864.8 39900.0 40328.6 3183.6 3247.3 3284.1 3361.7 3524.4 28824.6 30257.4 30275.5 30582.4 31299.8 3857.5 3892.6 3961.7 3997.8 4049.7 273065.0 273667.0 273683.0 274317.5 275267.0 50674.0 51651.5 51652.0 55725.7 56201.4 46253.5 59437.7 60481.4 61256.4 61356.4 12223.8 12246.9 12297.7 12335.6 12391.6 10048.6 10567.9 11184.4 11328.6 11336.5 18580.2 19121.8 19148.9 19232.1 19238.4 7353.6 7545.5 7676.8 7697.5 7729.7 871.3 950.3 1027.8 1034.0 1042.9 28052.3 28463.1 28549.0 29149.1 29281.9 998.0 1013.6 1032.1 1036.3 1093.1 13220.0 13281.6 13351.8 13413.0 13416.9 256645.0 261025.0 261411.0 261908.0 261985.0 46886.0 47080.3 47214.8 47321.0 47389.1 1323.5 1336.2 1338.1 1351.3 1363.2 24919.6 25890.2 26052.5 26118.2 26147.9 42061.4 42297.8 42327.8 42336.0 42370.8 295794.0 296777.0 299473.0 299552.0 299981.0 26018.7 29537.7 31012.2 31149.4 31219.4 35860.8 36393.0 36492.3 36786.3 36947.4 31729.8 31745.5 31891.4 32231.8 32481.8 31775.6 31939.8 32140.5 33408.2 35147.8 31106.5 31432.7 34745.0 35333.8 35682.6 28625.0 31385.2 31879.0 31934.8 32050.7 23758.6 23993.6 24169.4 24395.4 24724.8 05:14:51 INFO - PROCESS | 6592 | 05:14:51 INFO - PROCESS | 6592 | [#2] jquery.html Cycles:180 Average:27827.11 Median:21617.70 stddev:88453.25 (409.2%) stddev-sans-first:88677.33 05:14:51 INFO - PROCESS | 6592 | Values: 353.1 354.8 356.8 356.9 357.3 13617.4 13777.4 16508.8 17346.3 18523.4 15822.9 16417.4 16625.5 16983.4 17019.0 5350.4 5496.2 5506.6 5536.6 5543.7 4060.1 4194.9 5514.3 5552.8 5992.9 6018.1 6024.9 6058.0 6060.7 6094.9 5078.2 5216.3 5221.7 5232.1 6041.2 4976.4 5012.7 5016.0 5028.5 5271.6 11857.7 12202.8 12446.0 12469.8 12492.3 1992.9 2019.5 2022.7 2045.9 2184.5 9177.3 9392.0 9580.9 11149.6 12686.1 1741.9 1802.0 1837.4 1837.5 1922.8 59738.4 63022.7 63552.7 64248.7 64561.4 9334.7 9353.1 9414.9 9453.5 9587.4 12169.4 12197.9 12204.3 12206.6 12212.3 6863.4 6899.9 6906.3 6917.9 7162.5 6655.1 6716.4 7012.5 7221.0 7330.1 3943.0 3991.4 3994.9 4022.3 4037.2 1576.7 1622.3 1647.5 1656.2 1697.1 428.8 432.1 442.8 478.4 904.3 10504.6 10568.9 10702.2 10736.8 10819.4 451.0 452.8 459.2 463.6 486.1 5838.4 5896.4 5979.8 5993.8 6033.6 510207.0 517782.0 551649.0 557447.0 562512.0 78936.6 79662.6 80648.6 80715.6 81061.6 488.5 492.5 494.2 494.9 495.5 9975.2 10179.2 10213.6 10257.9 10378.3 31473.2 33217.3 33695.5 34019.0 34039.3 38573.0 42228.0 42806.6 43032.6 45231.1 9229.6 9522.2 9686.6 9728.2 9778.9 11193.3 11281.3 15518.6 16874.5 18070.9 11743.6 11874.8 12838.0 14051.1 14354.4 13468.2 13745.3 13905.0 13958.0 14396.6 13969.9 13993.7 14107.1 14192.4 14282.7 9211.8 9272.3 9331.8 9388.2 9464.3 10149.1 10277.5 13153.3 14239.7 14633.4 05:14:51 INFO - PROCESS | 6592 | 05:14:51 INFO - PROCESS | 6592 | [#3] mootools.html Cycles:180 Average:5208.93 Median:6094.64 stddev:2652.32 (43.5%) stddev-sans-first:2643.34 05:14:51 INFO - PROCESS | 6592 | Values: 1282.5 1389.5 1394.3 1484.5 1716.2 6577.7 7210.7 7348.5 7349.2 7356.3 7118.6 7280.7 7293.9 7297.6 7308.9 1963.6 2003.2 2226.4 2240.8 2278.7 2282.6 2285.0 2303.7 2307.3 2313.2 2174.0 2281.3 2281.5 2286.6 2287.4 2240.2 2241.5 2256.7 2280.0 2282.5 2255.7 2276.9 2282.8 2324.4 2325.3 7306.9 7477.1 7478.0 7481.0 7492.5 4518.2 4596.9 4625.1 4630.2 4634.2 2940.8 3001.3 3031.5 3040.0 3084.3 995.9 1011.5 1035.7 1049.5 1077.1 10105.3 10182.9 10187.4 10189.5 10198.4 4119.6 4172.7 4182.1 4266.7 4268.6 8753.9 8762.3 8771.2 8772.9 8781.6 4689.2 4689.6 4707.0 4722.3 4724.8 4209.2 4236.5 4237.9 4285.3 4286.3 3314.6 3360.4 3517.4 3519.9 3554.1 1098.8 1114.6 1118.4 1120.7 1122.0 1077.2 1248.2 1268.0 1269.9 1270.6 6792.4 6841.9 6845.7 6846.2 6849.6 961.4 962.7 991.0 1029.8 1063.0 5492.4 5594.0 5600.6 5619.7 5623.0 9043.5 9049.3 9072.7 9085.7 9359.4 8834.7 9210.5 9252.5 9253.5 9281.5 6743.8 6869.5 6899.3 6963.1 7048.5 6789.2 6835.1 6835.7 6837.4 6838.4 7770.5 7829.9 7844.2 7845.3 7869.4 7835.2 7973.4 8022.9 8104.1 8151.4 6438.1 6506.6 6562.5 6573.0 6589.6 6500.7 6562.1 6883.3 7047.2 7049.0 6463.6 6637.9 6695.0 6752.7 6780.3 6380.2 6405.8 6451.9 6487.7 6540.6 6348.7 6423.0 6431.9 6432.4 6437.2 5937.0 5950.1 5962.8 5974.2 5978.5 6210.8 6239.1 6273.0 6276.1 6285.1 05:14:51 INFO - PROCESS | 6592 | 05:14:51 INFO - PROCESS | 6592 | [#4] prototype.html Cycles:180 Average:5266.19 Median:5896.84 stddev:1573.44 (26.7%) stddev-sans-first:1533.74 05:14:51 INFO - PROCESS | 6592 | Values: 336.7 340.1 344.9 347.5 353.2 5831.8 5890.9 5891.1 5904.0 5948.4 5631.4 5681.4 5758.6 5812.3 5877.4 4568.0 4571.6 4571.6 4574.3 4582.8 4334.5 4568.5 4572.2 4577.4 4577.9 4378.6 4403.8 4497.0 4520.8 4524.7 4481.1 4483.1 4501.2 4501.3 4511.8 3984.2 3989.0 3989.1 3998.6 4000.3 5458.7 5547.9 5556.7 5557.9 5562.6 5271.6 5285.0 5292.5 5296.2 5299.5 6209.6 6218.7 6219.4 6220.7 6222.4 4419.0 4422.5 4423.8 4426.2 4427.9 6313.4 6465.7 6482.1 6496.1 6497.6 4551.4 4552.5 4556.9 4557.3 4560.7 4620.0 4626.2 4626.7 4627.8 4628.4 5293.0 5311.1 5334.7 5339.7 5347.2 6135.0 6258.8 6277.8 6278.6 6287.8 1612.1 1625.4 1631.5 1634.3 1634.4 1114.6 1120.7 1121.7 1123.1 1151.1 5902.6 5918.9 5919.5 5932.4 5938.4 6416.7 6417.3 6427.9 6431.6 6437.3 5786.0 5786.5 5886.9 6002.8 6014.1 3462.1 3475.8 3477.0 3487.9 3489.6 6683.7 6691.4 6692.7 6693.1 6702.6 6438.4 6587.9 6647.3 6667.3 6678.9 6764.8 6817.5 6822.3 6826.3 6835.5 6513.6 6513.7 6515.0 6518.9 6524.3 6319.0 6426.3 6426.4 6456.7 6462.9 6801.7 6817.9 6819.3 6828.0 6829.4 4465.0 4491.6 4492.0 4499.3 4502.9 6430.2 6538.7 6540.6 6551.3 6554.8 6307.2 6333.4 6335.6 6337.7 6371.8 6342.0 6346.2 6350.2 6354.9 6358.1 6025.2 6211.2 6235.6 6238.7 6248.5 6392.2 6395.8 6404.8 6405.6 6405.6 6165.4 6246.5 6247.0 6253.4 6253.9 05:14:51 INFO - PROCESS | 6592 | 05:14:51 INFO - PROCESS | 6592 | [#5] yui.html Cycles:180 Average:13533.23 Median:46574.88 stddev:15913.57 (34.2%) stddev-sans-first:15928.99 05:14:51 INFO - PROCESS | 6592 | Values: 692.4 799.3 800.8 808.7 813.5 11415.4 11455.4 11721.0 11765.5 11790.6 12125.3 12161.3 12175.8 12190.3 12208.4 668.6 680.1 793.4 807.9 809.2 802.3 811.7 818.8 819.1 819.4 826.5 835.5 840.8 841.2 841.9 679.8 688.5 830.6 838.9 857.3 624.1 625.8 629.1 629.1 629.3 12866.2 12979.9 13056.7 13064.9 13076.5 11186.9 11730.9 11752.2 11815.7 12133.2 10580.6 10593.4 10596.8 10702.3 10738.7 3554.9 3603.4 3620.5 3644.3 3723.1 46229.5 46336.5 46544.0 46605.8 46651.3 8232.8 8588.6 9015.5 9071.1 9208.3 17662.8 17678.7 17704.4 17732.5 17742.6 7021.0 7125.0 7142.4 7197.6 7527.7 3917.8 3927.5 3976.6 4016.1 4027.3 2960.8 2981.0 2986.6 2989.3 2998.7 487.0 488.6 495.8 509.0 517.7 527.1 555.9 636.9 638.9 659.2 8424.3 8498.0 8709.4 8839.4 8855.9 552.3 558.8 613.0 638.4 712.4 3777.2 4214.3 4352.6 4404.5 4423.9 60333.0 60714.7 60836.0 60880.7 60896.4 45876.3 46221.0 46249.0 46819.3 48726.0 42155.8 45591.3 46533.0 46843.5 47086.8 8062.8 8078.1 8496.1 8761.7 8912.3 34657.3 34795.0 34863.7 35657.8 35830.0 43119.6 45850.5 46824.3 47114.0 47597.0 9829.9 10332.9 10340.6 10352.8 10528.3 10819.4 10965.0 10989.4 11039.9 12313.6 10696.5 11274.2 11875.2 11910.6 12223.9 11600.9 11602.8 11764.6 11983.0 12193.5 11713.9 11751.4 11974.5 12175.0 12332.8 8698.8 8857.4 8864.0 9006.4 9100.4 8530.4 9140.6 9358.3 9548.7 10024.8 05:14:51 INFO - PROCESS | 6592 | -------- Summary: end -------- 05:14:51 INFO - PROCESS | 6592 | 05:14:52 INFO - TEST-INFO | 6592: exit 0 05:14:52 INFO - TEST-OK | dromaeo_css | took 1112969ms 05:14:52 INFO - TEST-START | kraken 05:14:52 INFO - operating with platform_type : linux_ 05:14:52 INFO - Initialising browser for kraken test... 05:14:52 INFO - TEST-INFO | started process 6785 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcu5mMS/profile http://localhost:59443/getInfo.html) 05:14:56 INFO - PROCESS | 6785 | __metrics Screen width/height:1600/1200 05:14:56 INFO - PROCESS | 6785 | colorDepth:24 05:14:56 INFO - PROCESS | 6785 | Browser inner width/height: 1024/697 05:14:56 INFO - PROCESS | 6785 | __metrics 05:14:56 INFO - PROCESS | 6785 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:14:56 INFO - PROCESS | 6785 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:14:57 INFO - TEST-INFO | 6785: exit 0 05:14:57 INFO - Browser initialized. 05:14:57 INFO - Running cycle 1/1 for kraken test... 05:14:57 INFO - TEST-INFO | started process 6870 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpcu5mMS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:09 INFO - PROCESS | 6870 | RSS: Main: 150327296 05:15:09 INFO - PROCESS | 6870 | 05:15:11 INFO - PROCESS | 6870 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59443/tests/kraken/driver.html?testName=audio-beat-detection) 05:15:12 INFO - PROCESS | 6870 | RSS: Main: 187404288 05:15:12 INFO - PROCESS | 6870 | 05:15:14 INFO - PROCESS | 6870 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59443/tests/kraken/driver.html?testName=audio-dft) 05:15:15 INFO - PROCESS | 6870 | RSS: Main: 176054272 05:15:15 INFO - PROCESS | 6870 | 05:15:18 INFO - PROCESS | 6870 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59443/tests/kraken/driver.html?testName=audio-fft) 05:15:18 INFO - PROCESS | 6870 | RSS: Main: 160083968 05:15:18 INFO - PROCESS | 6870 | 05:15:20 INFO - PROCESS | 6870 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59443/tests/kraken/driver.html?testName=audio-oscillator) 05:15:21 INFO - PROCESS | 6870 | RSS: Main: 163471360 05:15:21 INFO - PROCESS | 6870 | 05:15:23 INFO - PROCESS | 6870 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59443/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:15:24 INFO - PROCESS | 6870 | RSS: Main: 164999168 05:15:24 INFO - PROCESS | 6870 | 05:15:27 INFO - PROCESS | 6870 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59443/tests/kraken/driver.html?testName=imaging-darkroom) 05:15:27 INFO - PROCESS | 6870 | RSS: Main: 164765696 05:15:27 INFO - PROCESS | 6870 | 05:15:31 INFO - PROCESS | 6870 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59443/tests/kraken/driver.html?testName=imaging-desaturate) 05:15:31 INFO - PROCESS | 6870 | RSS: Main: 166330368 05:15:31 INFO - PROCESS | 6870 | 05:15:34 INFO - PROCESS | 6870 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59443/tests/kraken/driver.html?testName=json-parse-financial) 05:15:35 INFO - PROCESS | 6870 | RSS: Main: 165765120 05:15:35 INFO - PROCESS | 6870 | 05:15:36 INFO - PROCESS | 6870 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59443/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:15:37 INFO - PROCESS | 6870 | RSS: Main: 175464448 05:15:37 INFO - PROCESS | 6870 | 05:15:39 INFO - PROCESS | 6870 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59443/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:15:39 INFO - PROCESS | 6870 | RSS: Main: 173522944 05:15:39 INFO - PROCESS | 6870 | 05:15:41 INFO - PROCESS | 6870 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59443/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:15:42 INFO - PROCESS | 6870 | RSS: Main: 186662912 05:15:42 INFO - PROCESS | 6870 | 05:15:44 INFO - PROCESS | 6870 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:15:45 INFO - PROCESS | 6870 | RSS: Main: 194416640 05:15:45 INFO - PROCESS | 6870 | 05:15:47 INFO - PROCESS | 6870 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:15:48 INFO - PROCESS | 6870 | RSS: Main: 192409600 05:15:48 INFO - PROCESS | 6870 | 05:15:50 INFO - PROCESS | 6870 | Cycle 1(1): loaded http://localhost:59443/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59443/tests/kraken/driver.html?testName=ai-astar) 05:15:50 INFO - PROCESS | 6870 | RSS: Main: 250232832 05:15:50 INFO - PROCESS | 6870 | 05:15:50 INFO - PROCESS | 6870 | __start_tp_report 05:15:50 INFO - PROCESS | 6870 | _x_x_mozilla_page_load 05:15:50 INFO - PROCESS | 6870 | _x_x_mozilla_page_load_details 05:15:50 INFO - PROCESS | 6870 | |i|pagename|runs| 05:15:50 INFO - PROCESS | 6870 | |0;ai-astar;110;111;104;110;111;112;100;111;110;117 05:15:50 INFO - PROCESS | 6870 | |1;audio-beat-detection;152;125;173;164;125;156;148;127;163;128 05:15:50 INFO - PROCESS | 6870 | |2;audio-dft;161;161;164;161;161;164;161;162;161;162 05:15:50 INFO - PROCESS | 6870 | |3;audio-fft;71;72;90;91;70;73;75;111;96;73 05:15:50 INFO - PROCESS | 6870 | |4;audio-oscillator;97;96;139;97;97;97;141;95;96;151 05:15:50 INFO - PROCESS | 6870 | |5;imaging-gaussian-blur;108;109;109;109;109;109;109;109;109;109 05:15:50 INFO - PROCESS | 6870 | |6;imaging-darkroom;146;146;146;145;147;146;145;145;146;146 05:15:50 INFO - PROCESS | 6870 | |7;imaging-desaturate;96;97;96;97;97;97;96;96;96;95 05:15:50 INFO - PROCESS | 6870 | |8;json-parse-financial;59;58;57;56;56;58;57;67;55;55 05:15:50 INFO - PROCESS | 6870 | |9;json-stringify-tinderbox;67;67;68;68;68;68;67;67;68;67 05:15:50 INFO - PROCESS | 6870 | |10;stanford-crypto-aes;85;85;85;86;86;85;88;86;85;85 05:15:50 INFO - PROCESS | 6870 | |11;stanford-crypto-ccm;121;116;115;114;131;124;117;119;117;123 05:15:50 INFO - PROCESS | 6870 | |12;stanford-crypto-pbkdf2;141;143;143;151;154;143;163;157;145;143 05:15:50 INFO - PROCESS | 6870 | |13;stanford-crypto-sha256-iterative;69;71;70;68;71;69;68;67;68;67 05:15:50 INFO - PROCESS | 6870 | __end_tp_report 05:15:50 INFO - PROCESS | 6870 | __start_cc_report 05:15:50 INFO - PROCESS | 6870 | _x_x_mozilla_cycle_collect,924 05:15:50 INFO - PROCESS | 6870 | __end_cc_report 05:15:50 INFO - PROCESS | 6870 | __startTimestamp1451913350329__endTimestamp 05:15:50 INFO - PROCESS | 6870 | 05:15:50 INFO - PROCESS | 6870 | ------- Summary: start ------- 05:15:50 INFO - PROCESS | 6870 | Number of tests: 14 05:15:50 INFO - PROCESS | 6870 | 05:15:50 INFO - PROCESS | 6870 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:4.60 (4.1%) stddev-sans-first:4.88 05:15:50 INFO - PROCESS | 6870 | Values: 110.0 111.0 104.0 110.0 111.0 112.0 100.0 111.0 110.0 117.0 05:15:50 INFO - PROCESS | 6870 | 05:15:50 INFO - PROCESS | 6870 | [#1] audio-beat-detection Cycles:10 Average:146.10 Median:154.00 stddev:18.41 (12.0%) stddev-sans-first:19.40 05:15:50 INFO - PROCESS | 6870 | Values: 152.0 125.0 173.0 164.0 125.0 156.0 148.0 127.0 163.0 128.0 05:15:50 INFO - PROCESS | 6870 | 05:15:50 INFO - PROCESS | 6870 | [#2] audio-dft Cycles:10 Average:161.80 Median:161.50 stddev:1.23 (0.8%) stddev-sans-first:1.27 05:15:50 INFO - PROCESS | 6870 | Values: 161.0 161.0 164.0 161.0 161.0 164.0 161.0 162.0 161.0 162.0 05:15:50 INFO - PROCESS | 6870 | 05:15:50 INFO - PROCESS | 6870 | [#3] audio-fft Cycles:10 Average:82.20 Median:74.00 stddev:13.97 (18.9%) stddev-sans-first:14.22 05:15:50 INFO - PROCESS | 6870 | Values: 71.0 72.0 90.0 91.0 70.0 73.0 75.0 111.0 96.0 73.0 05:15:50 INFO - PROCESS | 6870 | 05:15:50 INFO - PROCESS | 6870 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:96.50 stddev:23.03 (23.9%) stddev-sans-first:23.89 05:15:50 INFO - PROCESS | 6870 | Values: 97.0 96.0 139.0 97.0 97.0 97.0 141.0 95.0 96.0 151.0 05:15:50 INFO - PROCESS | 6870 | 05:15:50 INFO - PROCESS | 6870 | [#5] imaging-gaussian-blur Cycles:10 Average:108.90 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 05:15:50 INFO - PROCESS | 6870 | Values: 108.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 05:15:50 INFO - PROCESS | 6870 | 05:15:50 INFO - PROCESS | 6870 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 05:15:50 INFO - PROCESS | 6870 | Values: 146.0 146.0 146.0 145.0 147.0 146.0 145.0 145.0 146.0 146.0 05:15:50 INFO - PROCESS | 6870 | 05:15:50 INFO - PROCESS | 6870 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 05:15:50 INFO - PROCESS | 6870 | Values: 96.0 97.0 96.0 97.0 97.0 97.0 96.0 96.0 96.0 95.0 05:15:50 INFO - PROCESS | 6870 | 05:15:50 INFO - PROCESS | 6870 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:57.50 stddev:3.49 (6.1%) stddev-sans-first:3.67 05:15:50 INFO - PROCESS | 6870 | Values: 59.0 58.0 57.0 56.0 56.0 58.0 57.0 67.0 55.0 55.0 05:15:50 INFO - PROCESS | 6870 | 05:15:50 INFO - PROCESS | 6870 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:68.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 05:15:50 INFO - PROCESS | 6870 | Values: 67.0 67.0 68.0 68.0 68.0 68.0 67.0 67.0 68.0 67.0 05:15:50 INFO - PROCESS | 6870 | 05:15:50 INFO - PROCESS | 6870 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.50 stddev:0.97 (1.1%) stddev-sans-first:1.00 05:15:50 INFO - PROCESS | 6870 | Values: 85.0 85.0 85.0 86.0 86.0 85.0 88.0 86.0 85.0 85.0 05:15:50 INFO - PROCESS | 6870 | 05:15:50 INFO - PROCESS | 6870 | [#11] stanford-crypto-ccm Cycles:10 Average:119.70 Median:120.00 stddev:5.19 (4.3%) stddev-sans-first:5.48 05:15:50 INFO - PROCESS | 6870 | Values: 121.0 116.0 115.0 114.0 131.0 124.0 117.0 119.0 117.0 123.0 05:15:50 INFO - PROCESS | 6870 | 05:15:50 INFO - PROCESS | 6870 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.30 Median:148.00 stddev:7.51 (5.1%) stddev-sans-first:7.49 05:15:50 INFO - PROCESS | 6870 | Values: 141.0 143.0 143.0 151.0 154.0 143.0 163.0 157.0 145.0 143.0 05:15:50 INFO - PROCESS | 6870 | 05:15:50 INFO - PROCESS | 6870 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.48 (2.1%) stddev-sans-first:1.56 05:15:50 INFO - PROCESS | 6870 | Values: 69.0 71.0 70.0 68.0 71.0 69.0 68.0 67.0 68.0 67.0 05:15:50 INFO - PROCESS | 6870 | -------- Summary: end -------- 05:15:50 INFO - PROCESS | 6870 | 05:15:51 INFO - TEST-INFO | 6870: exit 0 05:15:51 INFO - TEST-OK | kraken | took 59113ms 05:15:51 INFO - TEST-START | v8_7 05:15:51 INFO - operating with platform_type : linux_ 05:15:51 INFO - Initialising browser for v8_7 test... 05:15:51 INFO - TEST-INFO | started process 7122 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpynVM8y/profile http://localhost:59443/getInfo.html) 05:15:55 INFO - PROCESS | 7122 | __metrics Screen width/height:1600/1200 05:15:55 INFO - PROCESS | 7122 | colorDepth:24 05:15:55 INFO - PROCESS | 7122 | Browser inner width/height: 1024/697 05:15:55 INFO - PROCESS | 7122 | __metrics 05:15:55 INFO - PROCESS | 7122 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:15:55 INFO - PROCESS | 7122 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:15:56 INFO - TEST-INFO | 7122: exit 0 05:15:56 INFO - Browser initialized. 05:15:56 INFO - Running cycle 1/1 for v8_7 test... 05:15:56 INFO - TEST-INFO | started process 7208 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpynVM8y/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:16:08 INFO - PROCESS | 7208 | RSS: Main: 150167552 05:16:08 INFO - PROCESS | 7208 | 05:16:29 INFO - PROCESS | 7208 | Cycle 1(1): loaded http://localhost:59443/tests/v8_7/run.html (next: http://localhost:59443/tests/v8_7/run.html) 05:16:29 INFO - PROCESS | 7208 | RSS: Main: 556601344 05:16:29 INFO - PROCESS | 7208 | 05:16:29 INFO - PROCESS | 7208 | __start_tp_report 05:16:29 INFO - PROCESS | 7208 | _x_x_mozilla_page_load 05:16:29 INFO - PROCESS | 7208 | _x_x_mozilla_page_load_details 05:16:29 INFO - PROCESS | 7208 | |i|pagename|runs| 05:16:29 INFO - PROCESS | 7208 | |0;Richards;166.333998669328 05:16:29 INFO - PROCESS | 7208 | |1;DeltaBlue;191.42419601837673 05:16:29 INFO - PROCESS | 7208 | |2;Encrypt;283.04557033682426 05:16:29 INFO - PROCESS | 7208 | |3;Decrypt;5170.103092783505 05:16:29 INFO - PROCESS | 7208 | |4;RayTrace;1131.2217194570135 05:16:29 INFO - PROCESS | 7208 | |5;Earley;796.1783439490446 05:16:29 INFO - PROCESS | 7208 | |6;Boyer;12341.463414634147 05:16:29 INFO - PROCESS | 7208 | |7;RegExp;26153.846153846152 05:16:29 INFO - PROCESS | 7208 | |8;Splay;602.0469596628537 05:16:29 INFO - PROCESS | 7208 | |9;NavierStokes;4826.923076923077 05:16:29 INFO - PROCESS | 7208 | __end_tp_report 05:16:29 INFO - PROCESS | 7208 | __startTimestamp1451913389892__endTimestamp 05:16:29 INFO - PROCESS | 7208 | 05:16:29 INFO - PROCESS | 7208 | ------- Summary: start ------- 05:16:29 INFO - PROCESS | 7208 | Number of tests: 10 05:16:29 INFO - PROCESS | 7208 | 05:16:29 INFO - PROCESS | 7208 | [#0] Richards Cycles:1 Average:166.33 Median:166.33 stddev:0.00 (0.0%) 05:16:29 INFO - PROCESS | 7208 | Values: 166.3 05:16:29 INFO - PROCESS | 7208 | 05:16:29 INFO - PROCESS | 7208 | [#1] DeltaBlue Cycles:1 Average:191.42 Median:191.42 stddev:0.00 (0.0%) 05:16:29 INFO - PROCESS | 7208 | Values: 191.4 05:16:29 INFO - PROCESS | 7208 | 05:16:29 INFO - PROCESS | 7208 | [#2] Encrypt Cycles:1 Average:283.05 Median:283.05 stddev:0.00 (0.0%) 05:16:29 INFO - PROCESS | 7208 | Values: 283.0 05:16:29 INFO - PROCESS | 7208 | 05:16:29 INFO - PROCESS | 7208 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 05:16:29 INFO - PROCESS | 7208 | Values: 5170.1 05:16:29 INFO - PROCESS | 7208 | 05:16:29 INFO - PROCESS | 7208 | [#4] RayTrace Cycles:1 Average:1131.22 Median:1131.22 stddev:0.00 (0.0%) 05:16:29 INFO - PROCESS | 7208 | Values: 1131.2 05:16:29 INFO - PROCESS | 7208 | 05:16:29 INFO - PROCESS | 7208 | [#5] Earley Cycles:1 Average:796.18 Median:796.18 stddev:0.00 (0.0%) 05:16:29 INFO - PROCESS | 7208 | Values: 796.2 05:16:29 INFO - PROCESS | 7208 | 05:16:29 INFO - PROCESS | 7208 | [#6] Boyer Cycles:1 Average:12341.46 Median:12341.46 stddev:0.00 (0.0%) 05:16:29 INFO - PROCESS | 7208 | Values: 12341.5 05:16:29 INFO - PROCESS | 7208 | 05:16:29 INFO - PROCESS | 7208 | [#7] RegExp Cycles:1 Average:26153.85 Median:26153.85 stddev:0.00 (0.0%) 05:16:29 INFO - PROCESS | 7208 | Values: 26153.8 05:16:29 INFO - PROCESS | 7208 | 05:16:29 INFO - PROCESS | 7208 | [#8] Splay Cycles:1 Average:602.05 Median:602.05 stddev:0.00 (0.0%) 05:16:29 INFO - PROCESS | 7208 | Values: 602.0 05:16:29 INFO - PROCESS | 7208 | 05:16:29 INFO - PROCESS | 7208 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 05:16:29 INFO - PROCESS | 7208 | Values: 4826.9 05:16:29 INFO - PROCESS | 7208 | -------- Summary: end -------- 05:16:29 INFO - PROCESS | 7208 | 05:16:30 INFO - TEST-INFO | 7208: exit 0 05:16:30 INFO - TEST-OK | v8_7 | took 39481ms 05:16:30 INFO - SUITE-END | took 1211s 05:16:30 INFO - Completed test suite (00:20:11) 05:16:30 INFO - Working with test: dromaeo_css 05:16:30 INFO - Generating results file: dromaeo_css 05:16:30 INFO - Working with test: kraken 05:16:30 INFO - Generating results file: kraken 05:16:30 INFO - javascript benchmark 05:16:30 INFO - Working with test: v8_7 05:16:30 INFO - Generating results file: v8_7 05:16:30 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:16:30 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:16:30 INFO - process_Request line: dromaeo_css 6686.24 graph.html#tests=[[72,64,35]] 05:16:31 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:16:31 INFO - process_Request line: kraken 1509.00 graph.html#tests=[[232,64,35]] 05:16:31 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:16:31 INFO - process_Request line: v8_7 20891.21 graph.html#tests=[[230,64,35]] 05:16:31 INFO - RETURN: dromaeo_css: 6686.24 05:16:31 INFO - RETURN: kraken: 1509.00 05:16:31 INFO - RETURN: v8_7: 20891.21 05:16:31 INFO - javascript benchmark 05:16:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3035.8785648574058, 3139.419207446621, 3148.370325934811, 3155.873765049398, 3189.6331921828996, 5087.414947281064, 5220.216967454884, 5224.869378265541, 5241.240020197074, 5283.762230699618, 5274.841754747364, 5314.601404894639, 5383.703896285702, 5389.51494365507, 5393.325834270716, 4752.192127338343, 4793.9520604794025, 4846.273059041137, 4864.124457597631, 4893.4372547157, 4831.202851529511, 4835.178019736635, 4851.22380419133, 4904.264360345959, 4942.308076869242, 4702.153612349775, 4716.551927566876, 4782.450018247911, 4821.903561928777, 4861.392325959255, 4788.664793464459, 4790.688605240648, 4803.03939212159, 4830.5652491275605, 4838.854834354975, 4676.438827340707, 4797.904041919177, 4813.951860481386, 4816.060868130716, 4829.517048295177, 5044.218146187347, 5063.0, 5136.357955255593, 5161.5870730341485, 5245.160774276135, 5577.972110139464, 5583.3300003999375, 5586.329640443132, 5588.524975377098, 5599.132134519156, 5552.944470555283, 5597.384287728347, 5629.071203251499, 5652.74562644682, 5736.053551164053, 5237.528622423962, 5257.921131183035, 5345.572354211654, 5357.1696387060065, 5364.114921037985, 5807.535397168216, 5811.215485909348, 5814.098814683731, 5817.476427121494, 5864.824055278348, 5603.579731520153, 5604.0, 5614.606977511617, 5616.634918730269, 5617.550595952314, 5501.614886957875, 5571.860703482445, 5589.217509548666, 5679.318481782213, 5728.169415434739, 5638.85902852432, 5652.547796176296, 5667.4615911488345, 5673.716314184357, 5675.120356344773, 5473.644213126134, 5652.208690783294, 5671.9716401418555, 5673.716314184274, 5675.971620141955, 4338.956610433918, 4392.4289842320295, 4457.286834106528, 4461.263891457873, 4495.325701144854, 3865.8840234792438, 3870.8838734838, 3878.398848178537, 3883.456316115746, 3918.6081391861157, 5093.414257360451, 5189.818356357509, 5205.713685747321, 5205.9739701302005, 5249.291345668362, 5511.22842802008, 5623.044082505984, 5642.181883626851, 5645.2096706461125, 5697.145428185722, 5229.555487783581, 5235.554977826851, 5239.895202095937, 5246.0557099721655, 5280.9438112377675, 4732.881677958078, 4803.951960480351, 4823.662343635911, 4830.033993201374, 4841.515848415131, 5788.9290481261105, 5908.14331921869, 5930.377310382434, 5938.079597662369, 5982.820515384546, 5583.944160558342, 5620.85947851307, 5635.464630860061, 5636.436356364331, 5638.351589567088, 5571.637843540157, 5874.236349274567, 5882.617629854046, 5885.823425297248, 5889.469947704727, 5489.917651235155, 5495.725213739377, 5510.1459273812625, 5560.777568897199, 5566.276384070045, 5607.383187849415, 5613.1860880171325, 5614.326280846161, 5622.128570071645, 5622.381538030895, 5374.140137577969, 5483.561315094703, 5495.780168793203, 5496.395396506461, 5546.639468434539, 5400.864978375572, 5465.426130256265, 5471.452854714656, 5500.7524661391135, 5540.335159780852, 5478.178273259043, 5483.670979741229, 5486.204500347348, 5488.259085023471, 5503.642263253036, 5418.864528386822, 5573.331200255995, 5592.049351610155, 5613.214150018919, 5619.80330688424, 5311.362636483646, 5318.946810531846, 5395.568354531707, 5398.2712333836, 5404.83785486436], "unit": "score", "name": "dojo.html", "value": 5199.592718864518}, {"lowerIsBetter": false, "replicates": [525.2174260352075, 535.0449447735792, 538.644494633542, 553.5820455556055, 563.5097465205272, 28957.710422895765, 29528.261793455174, 35920.101997450045, 36859.447108293396, 37072.44391334125, 39132.60867391325, 39511.60488395115, 39537.802310988474, 39598.604013959855, 39605.40591891124, 7265.055542779432, 8403.83192336153, 8568.78578035551, 8570.87143692842, 8581.141885811432, 7388.667509962064, 7485.214052524489, 10033.448160351178, 10293.53679084443, 10306.433146176958, 10047.598096076148, 10169.389836609827, 10176.08415242628, 10177.898221017806, 10181.898181018207, 10022.24833137514, 10077.344972576759, 10083.0, 10123.79752404955, 10124.848127278097, 9811.656592019244, 9907.207423406111, 9927.453990030546, 9942.80114397708, 9946.20430365569, 36563.0, 37099.25801483982, 39864.800675996725, 39900.0, 40328.59671403278, 3183.602049743782, 3247.269364393016, 3284.113289411869, 3361.7142542883885, 3524.4360902255517, 28824.567631485545, 30257.394852102836, 30275.545866812015, 30582.388352233054, 31299.84350078235, 3857.517810273716, 3892.552356479013, 3961.6772427522706, 3997.8001099945177, 4049.6760259179196, 273065.0, 273667.0, 273683.0, 274317.51364972786, 275267.0, 50674.0, 51651.48348516467, 51651.96696066133, 55725.721371393694, 56201.43798562044, 46253.537464624926, 59437.70281148653, 60481.39518604758, 61256.38743612596, 61356.38643613596, 12223.816642750366, 12246.877531224753, 12297.692557686129, 12335.629931101901, 12391.62825115248, 10048.59805607782, 10567.94716026415, 11184.44077796107, 11328.603498877665, 11336.489857956412, 18580.163892624863, 19121.808781912, 19148.904255478632, 19232.134553945107, 19238.422847314603, 7353.6323183840595, 7545.50954187976, 7676.846463070708, 7697.461177717506, 7729.690812367555, 871.2942516561606, 950.2777888804559, 1027.8355463126013, 1033.9896601034043, 1042.854000439939, 28052.29869253285, 28463.146105616866, 28549.0, 29149.125526234246, 29281.853590732335, 998.0468652436905, 1013.6452241715341, 1032.1278519650882, 1036.2538971940191, 1093.0981939899455, 13220.0, 13281.601551953458, 13351.799723004162, 13413.0, 13416.932915335556, 256645.0, 261025.0, 261411.0, 261908.0, 261985.0, 46886.0, 47080.29379559309, 47214.763926180836, 47321.0, 47389.052218955425, 1323.5367621332457, 1336.1582203212108, 1338.1302153600043, 1351.250056218808, 1363.1957145284132, 24919.626205606568, 25890.22329330123, 26052.478950421264, 26118.216453506426, 26147.869260653573, 42061.36907946322, 42297.788511058476, 42327.78836105923, 42336.0, 42370.78814605907, 295794.0, 296777.0, 299473.0, 299552.0, 299981.0, 26018.73981260163, 29537.704622953497, 31012.22469438282, 31149.377012460078, 31219.37561248717, 35860.82069589636, 36393.0, 36492.270154596226, 36786.26427471382, 36947.44578831374, 31729.8413507931, 31745.5238171423, 31891.36217275688, 32231.838840805645, 32481.837590811894, 31775.616828737475, 31939.840300798347, 32140.517892232103, 33408.1647958803, 35147.82426087853, 31106.533401998535, 31432.68567314389, 34745.0, 35333.823330883184, 35682.64317356897, 28625.0, 31385.215369615944, 31879.0, 31934.84032579822, 32050.67949320477, 23758.643620345363, 23993.640095398932, 24169.39576510531, 24395.39011524726, 24724.752752472963], "unit": "score", "name": "ext.html", "value": 17702.28458603828}, {"lowerIsBetter": false, "replicates": [353.094313086932, 354.7534463547834, 356.8198059979712, 356.86617518430586, 357.25690563627654, 13617.387217575208, 13777.44890204393, 16508.752368714464, 17346.30614775409, 18523.351682691107, 15822.920885395586, 16417.425390111348, 16625.50123496294, 16983.405580804676, 17019.0, 5350.438203988583, 5496.1755736639625, 5506.64206826557, 5536.612437129403, 5543.722813859311, 4060.1473690525027, 4194.853180138696, 5514.338279406476, 5552.805651802188, 5992.940070599304, 6018.097285407202, 6024.879502409949, 6058.0, 6060.727267272983, 6094.939050609503, 5078.238264260372, 5216.26972223889, 5221.660592061504, 5232.136697444936, 6041.154238406627, 4976.4277108132665, 5012.72430016349, 5016.046951079284, 5028.522290382408, 5271.604629652791, 11857.703557411047, 12202.755944881053, 12446.0, 12469.75060498785, 12492.312922789242, 1992.870463419873, 2019.545602239499, 2022.6662600670873, 2045.92839250627, 2184.530325979906, 9177.265818734486, 9391.953040234755, 9580.89220371524, 11149.554017839277, 12686.111972161953, 1741.930322787087, 1802.0, 1837.4395809278165, 1837.5222442165, 1922.8173323534243, 59738.402615974155, 63022.684886575735, 63552.68223658898, 64248.67875660592, 64561.354386456005, 9334.7178816411, 9353.129374125203, 9414.905850941539, 9453.480058596706, 9587.376820506644, 12169.391530423443, 12197.878021219674, 12204.32876191818, 12206.572769953009, 12212.267263964191, 6863.352795329185, 6899.931000689929, 6906.309369063154, 6917.861642767217, 7162.4628152888745, 6655.134832471747, 6716.3955244028275, 7012.474064445187, 7220.963895180491, 7330.120385553768, 3942.9802850986134, 3991.4212439196153, 3994.9201015979515, 4022.3162062449455, 4037.2127435149864, 1576.65313631001, 1622.3186261770086, 1647.4645740134504, 1656.2215758593443, 1697.125980120239, 428.8220388538784, 432.11416595978744, 442.76975972494125, 478.42827820753865, 904.2547882586671, 10504.632337868137, 10568.894311056945, 10702.197335199735, 10736.838947415796, 10819.350838949687, 450.9842155524606, 452.75098695717224, 459.228496126504, 463.59898687635626, 486.10071367968976, 5838.38696936824, 5896.380880007623, 5979.790707325223, 5993.760249589967, 6033.637981721111, 510207.0, 517782.0, 551649.0, 557447.0, 562512.0, 78936.6053169742, 79662.6016869912, 80648.59675701584, 80715.59642201751, 81061.59469202734, 488.45049319515545, 492.4804331430447, 494.1944630252665, 494.9133901567283, 495.46242327074805, 9975.152112070555, 10179.185665146919, 10213.591456341663, 10257.897421025695, 10378.325408848401, 31473.21316967094, 33217.335653287286, 33695.494567582, 34019.0, 34039.31921361509, 38573.0, 42228.0, 42806.571934280255, 43032.56967430285, 45231.09537809291, 9229.630814767334, 9522.23822094217, 9686.612535498502, 9728.221742260745, 9778.853317200106, 11193.27243729155, 11281.32312061279, 15518.612034699223, 16874.463883181117, 18070.909645451688, 11743.588974385855, 11874.82187767167, 12838.0, 14051.086679365808, 14354.425822967381, 13468.19190848513, 13745.320221633983, 13905.026648134533, 13958.0, 14396.640083997983, 13969.860301397262, 13993.650158746113, 14107.083039602803, 14192.36134373935, 14282.71434571282, 9211.76970575741, 9272.258219342571, 9331.766705832408, 9388.202002829563, 9464.337496375188, 10149.086582207638, 10277.486125693536, 13153.342332883509, 14239.715205696035, 14633.414663413345], "unit": "score", "name": "jquery.html", "value": 7734.4088656941685}, {"lowerIsBetter": false, "replicates": [1282.5254655777364, 1389.5275606293858, 1394.31678477546, 1484.5249520153548, 1716.1848122141992, 6577.70400331985, 7210.675519601617, 7348.485606007568, 7349.228331025232, 7356.301151390609, 7118.644067796616, 7280.745173918914, 7293.890591641117, 7297.635118244079, 7308.890366644491, 1963.6072785442898, 2003.24878170686, 2226.3988723044768, 2240.764719704436, 2278.6695929090274, 2282.6347784354507, 2285.0402830811017, 2303.7120359955006, 2307.3308740465327, 2313.201945328859, 2173.9782602174014, 2281.349815302639, 2281.543691261746, 2286.5769832581027, 2287.3595393289906, 2240.19353032908, 2241.540484200735, 2256.740474845389, 2279.954400911989, 2282.5206706591634, 2255.7180352455944, 2276.8520046196945, 2282.794548490627, 2324.4305145239355, 2325.267540724666, 7306.890396644055, 7477.10274767026, 7477.962610186914, 7481.0, 7492.475526713132, 4518.2319005769095, 4596.885077873047, 4625.121226966866, 4630.166570017395, 4634.189016922059, 2940.8235505869716, 3001.3096987692734, 3031.4543382191196, 3040.0423866481988, 3084.33686757346, 995.9053889880449, 1011.4942528735633, 1035.7048241251282, 1049.5329578337644, 1077.0952399983973, 10105.343152695052, 10182.9490852546, 10187.388756674549, 10189.54147063384, 10198.43908585035, 4119.588041195916, 4172.72877262983, 4182.121754431542, 4266.658667306608, 4268.637165840876, 8753.91246087531, 8762.342824288204, 8771.16673915977, 8772.868406973901, 8781.648734050694, 4689.20283551797, 4689.554492323224, 4706.976465117721, 4722.338872557844, 4724.834630787975, 4209.158168366339, 4236.491621005499, 4237.851675191415, 4285.292926667127, 4286.314189729628, 3314.5691060162026, 3360.4119279126057, 3517.402041652925, 3519.8912342611993, 3554.147004718849, 1098.758273179899, 1114.570890207276, 1118.4184224203368, 1120.7030137013699, 1121.960731374398, 1077.1867240233573, 1248.182440501473, 1267.9619611411672, 1269.8666640002853, 1270.5997610752584, 6792.42264407521, 6841.863162736718, 6845.726170953206, 6846.178458585002, 6849.554778939353, 961.403929563675, 962.6678795815433, 990.9990909181778, 1029.7837454134715, 1062.990159348622, 5492.395836457987, 5594.0, 5600.551955843523, 5619.690916999522, 5622.971885140548, 9043.457392556467, 9049.276057915351, 9072.727818165466, 9085.727428177166, 9359.391639543408, 8834.734957951272, 9210.539473026322, 9252.49111298885, 9253.537323133816, 9281.535923203814, 6743.831404214836, 6869.519133660596, 6899.310068993061, 6963.09479767627, 7048.506604537633, 6789.1852977643, 6835.111435513351, 6835.69239384219, 6837.35045170708, 6838.418734407631, 7770.533767973713, 7829.921700782919, 7844.176361481962, 7845.293923546908, 7869.409794265567, 7835.216478352348, 7973.401994850294, 8022.91977080245, 8104.108548059591, 8151.429399942184, 6438.130852335063, 6506.642134682638, 6562.5406221564035, 6573.04690819838, 6589.604623722592, 6500.674966251574, 6562.114114594468, 6883.346082122191, 7047.154341479055, 7049.013138160764, 6463.64449955257, 6637.900431493628, 6694.966525167343, 6752.729890804313, 6780.288069752605, 6380.202474690664, 6405.8398540035005, 6451.935480645134, 6487.702459508023, 6540.640264785482, 6348.650824204713, 6422.967885160544, 6431.871362572816, 6432.388923052303, 6437.195350581177, 5937.0, 5950.077737950624, 5962.761489540369, 5974.193483879794, 5978.491828194652, 6210.782622608368, 6239.06414037898, 6272.968635156795, 6276.089966954857, 6285.120083188266], "unit": "score", "name": "mootools.html", "value": 4314.249378421781}, {"lowerIsBetter": false, "replicates": [336.7003367003367, 340.1411436123787, 344.85171376308176, 347.51868661903256, 353.2475826489577, 5831.766729330827, 5890.941090589093, 5891.086881533359, 5903.970480147598, 5948.375420580842, 5631.352394474627, 5681.375048744645, 5758.568107391952, 5812.273465816773, 5877.441643043915, 4568.040711450582, 4571.588557029867, 4571.588557029867, 4574.268117101273, 4582.839600613979, 4334.479862416514, 4568.497465278817, 4572.222722137245, 4577.382053422795, 4577.862664120065, 4378.605925466707, 4403.801828917706, 4496.9775151124195, 4520.841770538032, 4524.660650451213, 4481.081378317437, 4483.08096840147, 4501.212287849613, 4501.302298143776, 4511.751853648048, 3984.183242435323, 3989.0, 3989.1024519483176, 3998.5601583825755, 4000.2799496090693, 5458.6724796512335, 5547.916781248285, 5556.749946252428, 5557.944420555783, 5562.610617256793, 5271.578273738091, 5285.048691235576, 5292.470752924715, 5296.179092240709, 5299.54953828925, 6209.627422354673, 6218.657973811439, 6219.440250377443, 6220.720067596923, 6222.408871157233, 4418.955810441887, 4422.469303683579, 4423.845165419227, 4426.203283408985, 4427.933580996288, 6313.400226978476, 6465.709043093072, 6482.092507049017, 6496.123023391876, 6497.610143391459, 4551.431071116044, 4552.499225085238, 4556.863294101182, 4557.316402539645, 4560.703554269028, 4619.95380046202, 4626.167289887785, 4626.653001024936, 4627.838025669085, 4628.4445866496235, 5293.047251494768, 5311.070562651521, 5334.7065911374475, 5339.679619222781, 5347.224652425377, 6135.0, 6258.812235632939, 6277.843053923597, 6278.591891527036, 6287.842803929939, 1612.137506434052, 1625.4310991153002, 1631.4942367866, 1634.2727486268734, 1634.3789360043345, 1114.5987444519967, 1120.6806060272784, 1121.7195701074731, 1123.0678536814423, 1151.113642495274, 5902.58681892272, 5918.940810591925, 5919.467247947706, 5932.406759324033, 5938.406159384027, 6416.711247993851, 6417.326180751047, 6427.871442571122, 6431.614103153825, 6437.2918978912285, 5785.958527465013, 5786.537077033827, 5886.911696324559, 6002.759889604455, 6014.0678194879865, 3462.082548124749, 3475.8435870385892, 3477.0264325988765, 3487.9476807847905, 3489.616142224353, 6683.6658167091455, 6691.364320389555, 6692.6988285526295, 6693.1298931138645, 6702.597844129368, 6438.420542151229, 6587.934120658732, 6647.268800431949, 6667.299933507009, 6678.933210667831, 6764.830879228059, 6817.5227734059135, 6822.317768223138, 6826.317368263134, 6835.521513494107, 6513.641749703812, 6513.73945042193, 6514.967425163033, 6518.934810651833, 6524.3149469305035, 6319.0, 6426.29310775805, 6426.389492998158, 6456.6771661415805, 6462.935370646422, 6801.693923773343, 6817.863642727217, 6819.318068193141, 6828.044073829568, 6829.351211634887, 4464.955350446584, 4491.550844915482, 4491.955080449154, 4499.30260809562, 4502.909941801211, 6430.164078669743, 6538.705758240986, 6540.640264785482, 6551.344865513411, 6554.787364337612, 6307.180066591313, 6333.36666333363, 6335.556511044183, 6337.7148028337915, 6371.776987805404, 6341.968290158519, 6346.2067241594805, 6350.206224221973, 6354.936450635434, 6358.141650877257, 6025.1564780931585, 6211.161493198541, 6235.563510554218, 6238.6880655967925, 6248.468880145057, 6392.169018027626, 6395.840103997437, 6404.775832845828, 6405.551611387158, 6405.583637063576, 6165.445109940127, 6246.5002799775, 6247.0, 6253.405926436982, 6253.937460625518], "unit": "score", "name": "prototype.html", "value": 4762.966048493697}, {"lowerIsBetter": false, "replicates": [692.4460431654677, 799.3485309472776, 800.8438354520869, 808.6684459371659, 813.4590497319283, 11415.42922853857, 11455.427228638577, 11721.0, 11765.529378824858, 11790.646280611574, 12125.333106679129, 12161.270323780558, 12175.756484870297, 12190.329531875765, 12208.389580520983, 668.5921587831443, 680.0852852912824, 793.436659971421, 807.9313258373016, 809.2029351089172, 802.314021511608, 811.6793866422789, 818.7789296889836, 819.1276290750361, 819.3608984991686, 826.4793180296405, 835.5488036460304, 840.8066144786703, 841.2344766262702, 841.9031811341682, 679.8470344172547, 688.528358074718, 830.5722552885269, 838.8909441772591, 857.275602116217, 624.0794827629256, 625.7590827531433, 629.062696582094, 629.131798118598, 629.3046183966742, 12866.228026318357, 12979.935100324437, 13056.738865222642, 13064.86935130646, 13076.542321018718, 11186.944065279702, 11730.882691173065, 11752.177347585672, 11815.704607384798, 12133.150679452441, 10580.576776928914, 10593.36439813606, 10596.841047384296, 10702.304350217211, 10738.677839664822, 3554.9111272218142, 3603.387424137903, 3620.529331186955, 3644.344018076745, 3723.1064544509395, 46229.537704623195, 46336.53663463356, 46544.0, 46605.76697116526, 46651.30023049657, 8232.794180145544, 8588.570571471402, 9015.504147271831, 9071.138241867013, 9208.309376796768, 17662.823371766375, 17678.734818977726, 17704.38034668806, 17732.468025959242, 17742.645147096984, 7021.0, 7125.0, 7142.392896603847, 7197.640117994079, 7527.661255243527, 3917.7845218512684, 3927.5286965564314, 3976.58245884178, 4016.096378314856, 4027.335489644176, 2960.7779416543412, 2981.001364542859, 2986.566947792558, 2989.327401334726, 2998.7151220634005, 486.95860851827285, 488.57982135363557, 495.8289390160389, 508.98982020359387, 517.6945602094706, 527.0965189873433, 555.9082751345983, 636.9140166077613, 638.8562573420943, 659.2023651381786, 8424.283935865398, 8497.957510212409, 8709.433886797338, 8839.381243312906, 8855.867161992575, 552.3316786688072, 558.7653185662032, 612.953620506084, 638.4286063972719, 712.4229374206909, 3777.244551089793, 4214.325707886785, 4352.586504282088, 4404.493483249404, 4423.933640995388, 60333.0, 60714.696426517585, 60836.0, 60880.695596521735, 60896.39103608996, 45876.311855322194, 46221.0, 46249.0, 46819.29771053437, 48726.0, 42155.789221053696, 45591.31613025807, 46533.0, 46843.531564683915, 47086.76456617695, 8062.83874322522, 8078.111407745261, 8496.1079086695, 8761.693340733298, 8912.33157513176, 34657.306853862276, 34795.0, 34863.65136348604, 35657.82171089128, 35830.0, 43119.56880431156, 45850.54149458596, 46824.297635536175, 47114.0, 47597.0, 9829.899735621233, 10332.91504392028, 10340.586376544854, 10352.844707329547, 10528.315659482108, 10819.404932728776, 10965.0, 10989.395583242678, 11039.889601103887, 12313.56902508408, 10696.518656660313, 11274.154438416988, 11875.168738188244, 11910.642680719593, 12223.87776122263, 11600.88399115998, 11602.825957610474, 11764.58823941158, 11983.041356691618, 12193.451294691582, 11713.88286117128, 11751.412429378326, 11974.521019159136, 12175.0, 12332.753344933231, 8698.826023479622, 8857.424267422597, 8864.0, 9006.414583052081, 9100.408473449204, 8530.360222983178, 9140.588673509841, 9358.344915856098, 9548.70652308454, 10024.799504010025], "unit": "score", "name": "yui.html", "value": 6107.254798850864}], "name": "dromaeo_css", "value": 6686.240538128165}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 104.0, 110.0, 111.0, 112.0, 100.0, 111.0, 110.0, 117.0], "unit": "score", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [152.0, 125.0, 173.0, 164.0, 125.0, 156.0, 148.0, 127.0, 163.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.1}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 164.0, 161.0, 161.0, 164.0, 161.0, 162.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 90.0, 91.0, 70.0, 73.0, 75.0, 111.0, 96.0, 73.0], "unit": "score", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 139.0, 97.0, 97.0, 97.0, 141.0, 95.0, 96.0, 151.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 145.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.8}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 57.0, 56.0, 56.0, 58.0, 57.0, 67.0, 55.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 57.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 86.0, 86.0, 85.0, 88.0, 86.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [121.0, 116.0, 115.0, 114.0, 131.0, 124.0, 117.0, 119.0, 117.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.7}, {"lowerIsBetter": true, "replicates": [141.0, 143.0, 143.0, 151.0, 154.0, 143.0, 163.0, 157.0, 145.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.3}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 70.0, 68.0, 71.0, 69.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1508.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.333998669328], "unit": "score", "name": "Richards", "value": 212.23562399999997}, {"lowerIsBetter": false, "replicates": [191.42419601837673], "unit": "score", "name": "DeltaBlue", "value": 345.40043199999997}, {"lowerIsBetter": false, "replicates": [283.04557033682426], "unit": "score", "name": "Encrypt", "value": 940.4174729999997}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1131.2217194570135], "unit": "score", "name": "RayTrace", "value": 654.1502760000003}, {"lowerIsBetter": false, "replicates": [796.1783439490446], "unit": "score", "name": "Earley", "value": 837.077528}, {"lowerIsBetter": false, "replicates": [12341.463414634147], "unit": "score", "name": "Boyer", "value": 54.00194268774702}, {"lowerIsBetter": false, "replicates": [26153.846153846152], "unit": "score", "name": "RegExp", "value": 34.8317794117647}, {"lowerIsBetter": false, "replicates": [602.0469596628537], "unit": "score", "name": "Splay", "value": 135.35655099999997}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20891.20742775227}]} 05:16:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20891.21"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1509.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6686.24"}}} 05:16:31 INFO - Return code: 0 05:16:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:16:31 INFO - # TBPL SUCCESS # 05:16:31 INFO - Running post-action listener: _resource_record_post_action 05:16:31 INFO - Running post-run listener: _resource_record_post_run 05:16:32 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 0; Write bytes: 323313664; Read time: 0; Write time: 229312 05:16:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5431296; Read time: 0; Write time: 336 05:16:32 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 317882368; Read time: 0; Write time: 228976 05:16:32 INFO - Running post-run listener: _upload_blobber_files 05:16:32 INFO - Blob upload gear active. 05:16:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:16:32 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 05:16:32 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'] 05:16:32 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 05:16:32 INFO - (blobuploader) - INFO - Open directory for files ... 05:16:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:16:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:16:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:33 INFO - (blobuploader) - INFO - Done attempting. 05:16:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:16:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:16:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:16:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:16:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:16:34 INFO - (blobuploader) - INFO - Done attempting. 05:16:34 INFO - (blobuploader) - INFO - Iteration through files over. 05:16:34 INFO - Return code: 0 05:16:34 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:16:34 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:16:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6899366a63390c83c3cf91904ecb5909197819409f655dc40b02e285eff091cbdc24b5417d4acffddbea5ed738a5414affefd26d71bbded9aacec0fdd2f4db3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58064ec98f4eec56751aeb04c214cf1334f46dcf1fa6a2c4cd8de58d63fe5bc8b71cca21c5f2e391885ed6c7b6c59abf667b7fbbf3ed8e5c2abafd66f8ee07c8"} 05:16:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:16:34 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:16:34 INFO - Contents: 05:16:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6899366a63390c83c3cf91904ecb5909197819409f655dc40b02e285eff091cbdc24b5417d4acffddbea5ed738a5414affefd26d71bbded9aacec0fdd2f4db3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58064ec98f4eec56751aeb04c214cf1334f46dcf1fa6a2c4cd8de58d63fe5bc8b71cca21c5f2e391885ed6c7b6c59abf667b7fbbf3ed8e5c2abafd66f8ee07c8"} 05:16:34 INFO - Copying logs to upload dir... 05:16:34 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1267.586609 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-04 05:16:34.321470) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 05:16:34.324997) ========= 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=523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6899366a63390c83c3cf91904ecb5909197819409f655dc40b02e285eff091cbdc24b5417d4acffddbea5ed738a5414affefd26d71bbded9aacec0fdd2f4db3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58064ec98f4eec56751aeb04c214cf1334f46dcf1fa6a2c4cd8de58d63fe5bc8b71cca21c5f2e391885ed6c7b6c59abf667b7fbbf3ed8e5c2abafd66f8ee07c8"} build_url:https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011430 build_url: 'https://queue.taskcluster.net/v1/task/erjJR1aXQ-WYf8lqgf9B8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f6899366a63390c83c3cf91904ecb5909197819409f655dc40b02e285eff091cbdc24b5417d4acffddbea5ed738a5414affefd26d71bbded9aacec0fdd2f4db3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/58064ec98f4eec56751aeb04c214cf1334f46dcf1fa6a2c4cd8de58d63fe5bc8b71cca21c5f2e391885ed6c7b6c59abf667b7fbbf3ed8e5c2abafd66f8ee07c8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 05:16:34.350796) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 05:16:34.351137) ========= 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=523ca41ca1e0623de333ad52000001bf-1451910823.933182-1170664173 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 05:16:34.434516) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 05:16:34.434858) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 05:16:34.435195) ========= ========= Total master_lag: 0.25 =========