builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1450346378.02 results: success (0) buildid: 20151216233005 builduid: 2e55da5c5a3c48a1b21b394fcc03b7ea revision: 1afbb237019de001797d566cd33dd8fa5a9395d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.025025) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.025556) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.025843) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006355 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.068151) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.068432) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.098658) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.098933) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004570 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.151633) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.151936) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.152309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.152868) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 01:59:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2015-12-17 01:59:39 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.225735 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.397367) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.397670) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017322 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:38.446621) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 01:59:38.446980) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1afbb237019de001797d566cd33dd8fa5a9395d1 --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 1afbb237019de001797d566cd33dd8fa5a9395d1 --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=d7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 01:59:39,699 truncating revision to first 12 chars 2015-12-17 01:59:39,699 Setting DEBUG logging. 2015-12-17 01:59:39,699 attempt 1/10 2015-12-17 01:59:39,699 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1afbb237019d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 01:59:40,794 unpacking tar archive at: fx-team-1afbb237019d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.354451 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 01:59:39.814131) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:39.814438) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:39.824164) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:39.824470) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 01:59:39.824875) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-17 01:59:39.825185) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --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', '--system-bits', '64', '--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=d7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:59:41 INFO - MultiFileLogger online at 20151217 01:59:41 in /builds/slave/test-pgo 01:59:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:59:41 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 01:59:41 INFO - {'append_to_log': False, 01:59:41 INFO - 'base_work_dir': '/builds/slave/test-pgo', 01:59:41 INFO - 'blob_upload_branch': 'Fx-Team', 01:59:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 01:59:41 INFO - 'branch': 'Fx-Team', 01:59:41 INFO - 'buildbot_json_path': 'buildprops.json', 01:59:41 INFO - 'config_files': ('talos/linux_config.py',), 01:59:41 INFO - 'default_actions': ('clobber', 01:59:41 INFO - 'read-buildbot-config', 01:59:41 INFO - 'download-and-extract', 01:59:41 INFO - 'populate-webroot', 01:59:41 INFO - 'create-virtualenv', 01:59:41 INFO - 'install', 01:59:41 INFO - 'run-tests'), 01:59:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:59:41 INFO - 'download_minidump_stackwalk': True, 01:59:41 INFO - 'download_symbols': 'ondemand', 01:59:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:59:41 INFO - 'tooltool.py': '/tools/tooltool.py', 01:59:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:59:41 INFO - '/tools/misc-python/virtualenv.py')}, 01:59:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:59:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:59:41 INFO - 'installer_path': 'installer.exe', 01:59:41 INFO - 'log_level': 'info', 01:59:41 INFO - 'log_name': 'talos', 01:59:41 INFO - 'log_to_console': True, 01:59:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:59:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:59:41 INFO - 'opt_config_files': (), 01:59:41 INFO - 'pip_index': False, 01:59:41 INFO - 'sps_profile': False, 01:59:41 INFO - 'sps_profile_interval': 0, 01:59:41 INFO - 'suite': 'dromaeojs', 01:59:41 INFO - 'system_bits': '64', 01:59:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:59:41 INFO - 'title': 'talos-linux64-ix-068', 01:59:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:59:41 INFO - 'use_talos_json': True, 01:59:41 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 01:59:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:59:41 INFO - 'work_dir': 'build'} 01:59:41 INFO - ##### 01:59:41 INFO - ##### Running clobber step. 01:59:41 INFO - ##### 01:59:41 INFO - Running pre-action listener: _resource_record_pre_action 01:59:41 INFO - Running main action method: clobber 01:59:41 INFO - rmtree: /builds/slave/test-pgo/build 01:59:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 01:59:41 INFO - Running post-action listener: _resource_record_post_action 01:59:41 INFO - ##### 01:59:41 INFO - ##### Running read-buildbot-config step. 01:59:41 INFO - ##### 01:59:41 INFO - Running pre-action listener: _resource_record_pre_action 01:59:41 INFO - Running main action method: read_buildbot_config 01:59:41 INFO - Using buildbot properties: 01:59:41 INFO - { 01:59:41 INFO - "project": "", 01:59:41 INFO - "product": "firefox", 01:59:41 INFO - "script_repo_revision": "production", 01:59:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 01:59:41 INFO - "repository": "", 01:59:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 01:59:41 INFO - "buildid": "20151216233005", 01:59:41 INFO - "pgo_build": "True", 01:59:41 INFO - "basedir": "/builds/slave/test-pgo", 01:59:41 INFO - "buildnumber": 840, 01:59:41 INFO - "slavename": "talos-linux64-ix-068", 01:59:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:59:41 INFO - "platform": "ubuntu64_hw", 01:59:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 01:59:41 INFO - "branch": "fx-team", 01:59:41 INFO - "repo_path": "integration/fx-team", 01:59:41 INFO - "revision": "1afbb237019de001797d566cd33dd8fa5a9395d1", 01:59:41 INFO - "stage_platform": "linux64-pgo", 01:59:41 INFO - "builduid": "2e55da5c5a3c48a1b21b394fcc03b7ea", 01:59:41 INFO - "slavebuilddir": "test" 01:59:41 INFO - } 01:59:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:59:41 INFO - Running post-action listener: _resource_record_post_action 01:59:41 INFO - ##### 01:59:41 INFO - ##### Running download-and-extract step. 01:59:41 INFO - ##### 01:59:41 INFO - Running pre-action listener: _resource_record_pre_action 01:59:41 INFO - Running main action method: download_and_extract 01:59:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 01:59: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')]} 01:59:41 INFO - https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:59:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/test_packages.json 01:59:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/test_packages.json 01:59:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 01:59:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 01:59:42 INFO - Downloaded 1302 bytes. 01:59:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 01:59:42 INFO - Using the following test package requirements: 01:59:42 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:59:42 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:59:42 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:42 INFO - u'jsshell-linux-x86_64.zip'], 01:59:42 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:59:42 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:59:42 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:59:42 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:59:42 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:59:42 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:59:42 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:59:42 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:59:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:59:42 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')]} 01:59:42 INFO - https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/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 01:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/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 01:59:43 INFO - Downloaded 23118372 bytes. 01:59:43 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 01:59:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:43 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 01:59:44 INFO - Return code: 0 01:59:44 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 01:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:59:44 INFO - https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:59:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/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 01:59:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/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 01:59:57 INFO - Downloaded 23118372 bytes. 01:59:57 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 01:59:57 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:59:57 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 01:59:58 INFO - Return code: 0 01:59:58 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')]} 01:59:58 INFO - https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:59:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:59:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:59:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/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 01:59:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/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 01:59:59 INFO - Downloaded 11132052 bytes. 01:59:59 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 01:59:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:59:59 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 01:59:59 INFO - Return code: 0 01:59: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')]} 01:59:59 INFO - https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:59:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:59:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:59:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/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 01:59:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4HMDJFBvTYeeP2Gd2XypNA/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 02:00:01 INFO - Downloaded 59283175 bytes. 02:00:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:00:01 INFO - mkdir: /builds/slave/test-pgo/properties 02:00:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:00:01 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:00:01 INFO - Contents: 02:00:01 INFO - build_url:https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 02:00:01 INFO - Running post-action listener: _resource_record_post_action 02:00:01 INFO - Running post-action listener: set_extra_try_arguments 02:00:01 INFO - ##### 02:00:01 INFO - ##### Running populate-webroot step. 02:00:01 INFO - ##### 02:00:01 INFO - Running pre-action listener: _resource_record_pre_action 02:00:01 INFO - Running main action method: populate_webroot 02:00:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:00:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:00:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:00:01 INFO - '--tppagecycles', 02:00:01 INFO - '7'], 02:00:01 INFO - 'tests': ['tsvgm']}}, 02:00:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:00:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:00:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:00:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:00:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:00:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:00:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:00:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:01 INFO - 'talos_options': ['--e10s'], 02:00:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:00:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:01 INFO - 'tests': ['damp', 'tps']}, 02:00:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:01 INFO - 'talos_options': ['--e10s'], 02:00:01 INFO - 'tests': ['damp', 'tps']}, 02:00:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:00:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:00:01 INFO - 'other': {'tests': ['a11yr', 02:00:01 INFO - 'ts_paint', 02:00:01 INFO - 'tpaint', 02:00:01 INFO - 'sessionrestore', 02:00:01 INFO - 'sessionrestore_no_auto_restore']}, 02:00:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:00:01 INFO - 'tests': ['a11yr', 02:00:01 INFO - 'ts_paint', 02:00:01 INFO - 'tpaint', 02:00:01 INFO - 'sessionrestore', 02:00:01 INFO - 'sessionrestore_no_auto_restore']}, 02:00:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:00:01 INFO - 'tests': ['a11yr', 02:00:01 INFO - 'ts_paint', 02:00:01 INFO - 'tpaint', 02:00:01 INFO - 'sessionrestore', 02:00:01 INFO - 'sessionrestore_no_auto_restore']}, 02:00:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:00:01 INFO - 'tests': ['a11yr', 02:00:01 INFO - 'ts_paint', 02:00:01 INFO - 'tpaint', 02:00:01 INFO - 'sessionrestore', 02:00:01 INFO - 'sessionrestore_no_auto_restore']}, 02:00:01 INFO - 'other_l64': {'tests': ['a11yr', 02:00:01 INFO - 'ts_paint', 02:00:01 INFO - 'tpaint', 02:00:01 INFO - 'sessionrestore', 02:00:01 INFO - 'sessionrestore_no_auto_restore']}, 02:00:01 INFO - 'other_nol64': {'tests': ['a11yr', 02:00:01 INFO - 'ts_paint', 02:00:01 INFO - 'tpaint', 02:00:01 INFO - 'sessionrestore', 02:00:01 INFO - 'sessionrestore_no_auto_restore']}, 02:00:01 INFO - 'svgr': {'tests': ['tsvgx', 02:00:01 INFO - 'tsvgr_opacity', 02:00:01 INFO - 'tart', 02:00:01 INFO - 'tscrollx', 02:00:01 INFO - 'cart']}, 02:00:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:00:01 INFO - 'tests': ['tsvgx', 02:00:01 INFO - 'tsvgr_opacity', 02:00:01 INFO - 'tart', 02:00:01 INFO - 'tscrollx', 02:00:01 INFO - 'cart']}, 02:00:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:01 INFO - 'tests': ['tp5o']}, 02:00:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:01 INFO - 'talos_options': ['--e10s'], 02:00:01 INFO - 'tests': ['tp5o']}, 02:00:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:01 INFO - 'talos_options': ['--xperf_path', 02:00:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:00:01 INFO - 'tests': ['tp5n']}, 02:00:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:00:01 INFO - 'talos_options': ['--e10s', 02:00:01 INFO - '--xperf_path', 02:00:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:00:01 INFO - 'tests': ['tp5n']}}, 02:00:01 INFO - 'talos.zip': {'path': '', 02:00:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:00:01 INFO - Running post-action listener: _resource_record_post_action 02:00:01 INFO - ##### 02:00:01 INFO - ##### Running create-virtualenv step. 02:00:01 INFO - ##### 02:00:01 INFO - Running pre-action listener: _resource_record_pre_action 02:00:01 INFO - Running main action method: create_virtualenv 02:00:01 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:00:01 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 02:00:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:00:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:00:01 INFO - Using real prefix '/usr' 02:00:01 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:00:01 INFO - Installing distribute.............................................................................................................................................................................................done. 02:00:03 INFO - Installing pip.................done. 02:00:03 INFO - Return code: 0 02:00:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:00:03 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')]} 02:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:03 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')]} 02:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:03 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 0x7f4557a45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa350>, '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 0x25fb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fb6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', '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 02:00:03 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 02:00:03 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 02:00:03 INFO - Using env: {'DISPLAY': ':0', 02:00:03 INFO - 'HOME': '/home/cltbld', 02:00:03 INFO - 'LANG': 'en_US.UTF-8', 02:00:03 INFO - 'LANGUAGE': 'en_US:en', 02:00:03 INFO - 'LOGNAME': 'cltbld', 02:00:03 INFO - 'MAIL': '/var/mail/cltbld', 02:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:03 INFO - 'MOZ_NO_REMOTE': '1', 02:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:03 INFO - 'NO_EM_RESTART': '1', 02:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:03 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:03 INFO - 'SHELL': '/bin/bash', 02:00:03 INFO - 'SHLVL': '1', 02:00:03 INFO - 'TERM': 'linux', 02:00:03 INFO - 'TMOUT': '86400', 02:00:03 INFO - 'USER': 'cltbld', 02:00:03 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', 02:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:03 INFO - '_': '/tools/buildbot/bin/python'} 02:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:03 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 02:00:03 INFO - Cleaning up... 02:00:03 INFO - Return code: 0 02:00:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:00:03 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')]} 02:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:03 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')]} 02:00:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:03 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 0x7f4557a45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa350>, '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 0x25fb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fb6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', '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 02:00:03 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 02:00:03 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 02:00:03 INFO - Using env: {'DISPLAY': ':0', 02:00:03 INFO - 'HOME': '/home/cltbld', 02:00:03 INFO - 'LANG': 'en_US.UTF-8', 02:00:03 INFO - 'LANGUAGE': 'en_US:en', 02:00:03 INFO - 'LOGNAME': 'cltbld', 02:00:03 INFO - 'MAIL': '/var/mail/cltbld', 02:00:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:03 INFO - 'MOZ_NO_REMOTE': '1', 02:00:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:03 INFO - 'NO_EM_RESTART': '1', 02:00:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:03 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:03 INFO - 'SHELL': '/bin/bash', 02:00:03 INFO - 'SHLVL': '1', 02:00:03 INFO - 'TERM': 'linux', 02:00:03 INFO - 'TMOUT': '86400', 02:00:03 INFO - 'USER': 'cltbld', 02:00:03 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', 02:00:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:03 INFO - '_': '/tools/buildbot/bin/python'} 02:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:04 INFO - Downloading/unpacking psutil>=0.7.1 02:00:04 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 02:00:04 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 02:00:04 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 02:00:04 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 02:00:04 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 02:00:04 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 02:00:06 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 02:00:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 02:00:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:00:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:00:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:00:06 INFO - Installing collected packages: psutil 02:00:06 INFO - Running setup.py install for psutil 02:00:06 INFO - building 'psutil._psutil_linux' extension 02:00:06 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 02:00:06 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 02:00:06 INFO - building 'psutil._psutil_posix' extension 02:00:06 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 02:00:07 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 02:00:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:00:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:00:07 INFO - Successfully installed psutil 02:00:07 INFO - Cleaning up... 02:00:07 INFO - Return code: 0 02:00:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:00:07 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')]} 02:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:07 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')]} 02:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:07 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 0x7f4557a45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa350>, '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 0x25fb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fb6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', '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 02:00:07 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 02:00:07 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 02:00:07 INFO - Using env: {'DISPLAY': ':0', 02:00:07 INFO - 'HOME': '/home/cltbld', 02:00:07 INFO - 'LANG': 'en_US.UTF-8', 02:00:07 INFO - 'LANGUAGE': 'en_US:en', 02:00:07 INFO - 'LOGNAME': 'cltbld', 02:00:07 INFO - 'MAIL': '/var/mail/cltbld', 02:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:07 INFO - 'MOZ_NO_REMOTE': '1', 02:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:07 INFO - 'NO_EM_RESTART': '1', 02:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:07 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:07 INFO - 'SHELL': '/bin/bash', 02:00:07 INFO - 'SHLVL': '1', 02:00:07 INFO - 'TERM': 'linux', 02:00:07 INFO - 'TMOUT': '86400', 02:00:07 INFO - 'USER': 'cltbld', 02:00:07 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', 02:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:07 INFO - '_': '/tools/buildbot/bin/python'} 02:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:00:07 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 02:00:07 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 02:00:07 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 02:00:07 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 02:00:07 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 02:00:07 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 02:00:09 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:00:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 02:00:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:00:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:00:09 INFO - Installing collected packages: mozsystemmonitor 02:00:09 INFO - Running setup.py install for mozsystemmonitor 02:00:09 INFO - Successfully installed mozsystemmonitor 02:00:09 INFO - Cleaning up... 02:00:09 INFO - Return code: 0 02:00:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:00:09 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')]} 02:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:09 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')]} 02:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:09 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 0x7f4557a45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa350>, '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 0x25fb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fb6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', '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 02:00:09 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 02:00:09 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 02:00:09 INFO - Using env: {'DISPLAY': ':0', 02:00:09 INFO - 'HOME': '/home/cltbld', 02:00:09 INFO - 'LANG': 'en_US.UTF-8', 02:00:09 INFO - 'LANGUAGE': 'en_US:en', 02:00:09 INFO - 'LOGNAME': 'cltbld', 02:00:09 INFO - 'MAIL': '/var/mail/cltbld', 02:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:09 INFO - 'MOZ_NO_REMOTE': '1', 02:00:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:09 INFO - 'NO_EM_RESTART': '1', 02:00:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:09 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:09 INFO - 'SHELL': '/bin/bash', 02:00:09 INFO - 'SHLVL': '1', 02:00:09 INFO - 'TERM': 'linux', 02:00:09 INFO - 'TMOUT': '86400', 02:00:09 INFO - 'USER': 'cltbld', 02:00:09 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', 02:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:09 INFO - '_': '/tools/buildbot/bin/python'} 02:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:09 INFO - Downloading/unpacking blobuploader==1.2.4 02:00:09 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 02:00:09 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 02:00:09 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 02:00:09 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 02:00:09 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 02:00:09 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 02:00:11 INFO - Downloading blobuploader-1.2.4.tar.gz 02:00:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 02:00:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:00:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:00:11 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 02:00:11 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 02:00:11 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 02:00:11 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 02:00:11 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 02:00:11 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 02:00:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 02:00:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:00:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:00:11 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 02:00:11 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 02:00:11 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 02:00:11 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 02:00:11 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 02:00:11 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 02:00:11 INFO - Downloading docopt-0.6.1.tar.gz 02:00:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 02:00:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:00:11 INFO - Installing collected packages: blobuploader, requests, docopt 02:00:11 INFO - Running setup.py install for blobuploader 02:00:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:00:11 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:00:11 INFO - Running setup.py install for requests 02:00:12 INFO - Running setup.py install for docopt 02:00:12 INFO - Successfully installed blobuploader requests docopt 02:00:12 INFO - Cleaning up... 02:00:12 INFO - Return code: 0 02:00:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:00:12 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')]} 02:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:12 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')]} 02:00:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:12 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 0x7f4557a45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa350>, '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 0x25fb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fb6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', '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 02:00:12 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 02:00:12 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 02:00:12 INFO - Using env: {'DISPLAY': ':0', 02:00:12 INFO - 'HOME': '/home/cltbld', 02:00:12 INFO - 'LANG': 'en_US.UTF-8', 02:00:12 INFO - 'LANGUAGE': 'en_US:en', 02:00:12 INFO - 'LOGNAME': 'cltbld', 02:00:12 INFO - 'MAIL': '/var/mail/cltbld', 02:00:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:12 INFO - 'MOZ_NO_REMOTE': '1', 02:00:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:12 INFO - 'NO_EM_RESTART': '1', 02:00:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:12 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:12 INFO - 'SHELL': '/bin/bash', 02:00:12 INFO - 'SHLVL': '1', 02:00:12 INFO - 'TERM': 'linux', 02:00:12 INFO - 'TMOUT': '86400', 02:00:12 INFO - 'USER': 'cltbld', 02:00:12 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', 02:00:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:12 INFO - '_': '/tools/buildbot/bin/python'} 02:00:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:00:12 INFO - Running setup.py (path:/tmp/pip-k259tU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:00:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:00:12 INFO - Running setup.py (path:/tmp/pip-rSADr4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:00:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:00:12 INFO - Running setup.py (path:/tmp/pip-CpSVNy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:00:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:00:12 INFO - Running setup.py (path:/tmp/pip-bDakC_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:00:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:00:12 INFO - Running setup.py (path:/tmp/pip-GkC8tC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:00:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:00:13 INFO - Running setup.py (path:/tmp/pip-eG7y1r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:00:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:00:13 INFO - Running setup.py (path:/tmp/pip-CLrkTI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:00:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:00:13 INFO - Running setup.py (path:/tmp/pip-krMVkJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:00:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:00:13 INFO - Running setup.py (path:/tmp/pip-DbYK6N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:00:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:00:13 INFO - Running setup.py (path:/tmp/pip-p3fw_w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:00:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:00:13 INFO - Running setup.py (path:/tmp/pip-jxqzuN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:00:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:00:13 INFO - Running setup.py (path:/tmp/pip-XKHOS2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:00:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:00:13 INFO - Running setup.py (path:/tmp/pip-u6a90l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:00:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:00:13 INFO - Running setup.py (path:/tmp/pip-kZihYQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:00:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:00:13 INFO - Running setup.py (path:/tmp/pip-nBfXjN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:00:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:00:13 INFO - Running setup.py (path:/tmp/pip-IymE0O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:00:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:00:13 INFO - Running setup.py (path:/tmp/pip-1x1RA9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:00:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:00:13 INFO - Running setup.py install for manifestparser 02:00:13 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:00:14 INFO - Running setup.py install for mozcrash 02:00:14 INFO - Running setup.py install for mozdebug 02:00:14 INFO - Running setup.py install for mozdevice 02:00:14 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:00:14 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:00:14 INFO - Running setup.py install for mozfile 02:00:14 INFO - Running setup.py install for mozhttpd 02:00:14 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:00:14 INFO - Running setup.py install for mozinfo 02:00:14 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:00:14 INFO - Running setup.py install for mozInstall 02:00:14 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:00:14 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:00:14 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:00:14 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:00:14 INFO - Running setup.py install for mozleak 02:00:14 INFO - Running setup.py install for mozlog 02:00:14 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:00:14 INFO - Running setup.py install for moznetwork 02:00:15 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:00:15 INFO - Running setup.py install for mozprocess 02:00:15 INFO - Running setup.py install for mozprofile 02:00:15 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:00:15 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:00:15 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:00:15 INFO - Running setup.py install for mozrunner 02:00:15 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:00:15 INFO - Running setup.py install for mozscreenshot 02:00:15 INFO - Running setup.py install for moztest 02:00:15 INFO - Running setup.py install for mozversion 02:00:15 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:00:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:00:15 INFO - Cleaning up... 02:00:15 INFO - Return code: 0 02:00:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:00:15 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')]} 02:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:15 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')]} 02:00:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:15 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 0x7f4557a45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa350>, '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 0x25fb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fb6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', '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 02:00:15 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 02:00:15 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 02:00:15 INFO - Using env: {'DISPLAY': ':0', 02:00:15 INFO - 'HOME': '/home/cltbld', 02:00:15 INFO - 'LANG': 'en_US.UTF-8', 02:00:15 INFO - 'LANGUAGE': 'en_US:en', 02:00:15 INFO - 'LOGNAME': 'cltbld', 02:00:15 INFO - 'MAIL': '/var/mail/cltbld', 02:00:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:15 INFO - 'MOZ_NO_REMOTE': '1', 02:00:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:15 INFO - 'NO_EM_RESTART': '1', 02:00:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:15 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:15 INFO - 'SHELL': '/bin/bash', 02:00:15 INFO - 'SHLVL': '1', 02:00:15 INFO - 'TERM': 'linux', 02:00:15 INFO - 'TMOUT': '86400', 02:00:15 INFO - 'USER': 'cltbld', 02:00:15 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', 02:00:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:15 INFO - '_': '/tools/buildbot/bin/python'} 02:00:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:00:15 INFO - Running setup.py (path:/tmp/pip-PpQgVH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:00:15 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)) 02:00:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:00:15 INFO - Running setup.py (path:/tmp/pip-NIOFdR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:00:16 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)) 02:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:00:16 INFO - Running setup.py (path:/tmp/pip-zkhP1b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:00:16 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)) 02:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:00:16 INFO - Running setup.py (path:/tmp/pip-B8Q4s3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:00:16 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)) 02:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:00:16 INFO - Running setup.py (path:/tmp/pip-Kv3FrB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:00:16 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)) 02:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:00:16 INFO - Running setup.py (path:/tmp/pip-2i_9cP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:00:16 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)) 02:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:00:16 INFO - Running setup.py (path:/tmp/pip-AvKUev-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:00:16 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)) 02:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:00:16 INFO - Running setup.py (path:/tmp/pip-wchE79-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:00:16 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)) 02:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:00:16 INFO - Running setup.py (path:/tmp/pip-v0akRr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:00:16 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)) 02:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:00:16 INFO - Running setup.py (path:/tmp/pip-GwqUVx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:00:16 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)) 02:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:00:16 INFO - Running setup.py (path:/tmp/pip-fa9jNw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:00:16 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)) 02:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:00:16 INFO - Running setup.py (path:/tmp/pip-5T06il-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:00:16 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)) 02:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:00:16 INFO - Running setup.py (path:/tmp/pip-Q2a_gq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 02:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:00:16 INFO - Running setup.py (path:/tmp/pip-Eogb1P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:00:16 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)) 02:00:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:00:16 INFO - Running setup.py (path:/tmp/pip-UcZkL5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:00:17 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)) 02:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:00:17 INFO - Running setup.py (path:/tmp/pip-v2mJAo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:00:17 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)) 02:00:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:00:17 INFO - Running setup.py (path:/tmp/pip-yo99HP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:00:17 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)) 02:00:17 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)) 02:00:17 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)) 02:00:17 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)) 02:00:17 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)) 02:00:17 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)) 02:00:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:00:17 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 02:00:17 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 02:00:17 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 02:00:17 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 02:00:17 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 02:00:17 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 02:00:18 INFO - Downloading blessings-1.5.1.tar.gz 02:00:18 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 02:00:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:00:18 INFO - Installing collected packages: blessings 02:00:18 INFO - Running setup.py install for blessings 02:00:19 INFO - Successfully installed blessings 02:00:19 INFO - Cleaning up... 02:00:19 INFO - Return code: 0 02:00:19 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:00:19 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:00:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:00:19 INFO - Reading from file tmpfile_stdout 02:00:19 INFO - Current package versions: 02:00:19 INFO - argparse == 1.2.1 02:00:19 INFO - blessings == 1.5.1 02:00:19 INFO - blobuploader == 1.2.4 02:00:19 INFO - docopt == 0.6.1 02:00:19 INFO - manifestparser == 1.1 02:00:19 INFO - mozInstall == 1.12 02:00:19 INFO - mozcrash == 0.16 02:00:19 INFO - mozdebug == 0.1 02:00:19 INFO - mozdevice == 0.47 02:00:19 INFO - mozfile == 1.2 02:00:19 INFO - mozhttpd == 0.7 02:00:19 INFO - mozinfo == 0.9 02:00:19 INFO - mozleak == 0.1 02:00:19 INFO - mozlog == 3.1 02:00:19 INFO - moznetwork == 0.27 02:00:19 INFO - mozprocess == 0.22 02:00:19 INFO - mozprofile == 0.27 02:00:19 INFO - mozrunner == 6.11 02:00:19 INFO - mozscreenshot == 0.1 02:00:19 INFO - mozsystemmonitor == 0.0 02:00:19 INFO - moztest == 0.7 02:00:19 INFO - mozversion == 1.4 02:00:19 INFO - psutil == 3.1.1 02:00:19 INFO - requests == 1.2.3 02:00:19 INFO - wsgiref == 0.1.2 02:00:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:00:19 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')]} 02:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:19 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')]} 02:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:19 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 0x7f4557a45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa350>, '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 0x25fb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fb6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', '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 02:00:19 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 02:00:19 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 02:00:19 INFO - Using env: {'DISPLAY': ':0', 02:00:19 INFO - 'HOME': '/home/cltbld', 02:00:19 INFO - 'LANG': 'en_US.UTF-8', 02:00:19 INFO - 'LANGUAGE': 'en_US:en', 02:00:19 INFO - 'LOGNAME': 'cltbld', 02:00:19 INFO - 'MAIL': '/var/mail/cltbld', 02:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:19 INFO - 'MOZ_NO_REMOTE': '1', 02:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:19 INFO - 'NO_EM_RESTART': '1', 02:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:19 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:19 INFO - 'SHELL': '/bin/bash', 02:00:19 INFO - 'SHLVL': '1', 02:00:19 INFO - 'TERM': 'linux', 02:00:19 INFO - 'TMOUT': '86400', 02:00:19 INFO - 'USER': 'cltbld', 02:00:19 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', 02:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:19 INFO - '_': '/tools/buildbot/bin/python'} 02:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:19 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 1)) 02:00:19 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 2)) 02:00:19 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 3)) 02:00:19 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 4)) 02:00:19 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 5)) 02:00:19 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 6)) 02:00:19 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 7)) 02:00:19 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 8)) 02:00:19 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 02:00:19 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 3)) 02:00:19 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 02:00:19 INFO - Cleaning up... 02:00:19 INFO - Return code: 0 02:00:19 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:00:19 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')]} 02:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:19 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')]} 02:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:19 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 0x7f4557a45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa350>, '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 0x25fb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fb6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', '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 02:00:19 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 02:00:19 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 02:00:19 INFO - Using env: {'DISPLAY': ':0', 02:00:19 INFO - 'HOME': '/home/cltbld', 02:00:19 INFO - 'LANG': 'en_US.UTF-8', 02:00:19 INFO - 'LANGUAGE': 'en_US:en', 02:00:19 INFO - 'LOGNAME': 'cltbld', 02:00:19 INFO - 'MAIL': '/var/mail/cltbld', 02:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:19 INFO - 'MOZ_NO_REMOTE': '1', 02:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:19 INFO - 'NO_EM_RESTART': '1', 02:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:19 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:19 INFO - 'SHELL': '/bin/bash', 02:00:19 INFO - 'SHLVL': '1', 02:00:19 INFO - 'TERM': 'linux', 02:00:19 INFO - 'TMOUT': '86400', 02:00:19 INFO - 'USER': 'cltbld', 02:00:19 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', 02:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:19 INFO - '_': '/tools/buildbot/bin/python'} 02:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:19 INFO - Downloading/unpacking jsonschema 02:00:19 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 02:00:19 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 02:00:19 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 02:00:19 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 02:00:19 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 02:00:19 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 02:00:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:00:21 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 02:00:21 INFO - Downloading/unpacking functools32 (from jsonschema) 02:00:21 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 02:00:21 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 02:00:21 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 02:00:21 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 02:00:21 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 02:00:21 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 02:00:21 INFO - Downloading functools32-3.2.3-2.tar.gz 02:00:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 02:00:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:00:21 INFO - warning: no files found matching '*.txt' 02:00:21 INFO - no previously-included directories found matching 'build' 02:00:21 INFO - no previously-included directories found matching 'dist' 02:00:21 INFO - no previously-included directories found matching '.git*' 02:00:21 INFO - Installing collected packages: jsonschema, functools32 02:00:21 INFO - Running setup.py install for functools32 02:00:21 INFO - warning: no files found matching '*.txt' 02:00:21 INFO - no previously-included directories found matching 'build' 02:00:21 INFO - no previously-included directories found matching 'dist' 02:00:21 INFO - no previously-included directories found matching '.git*' 02:00:21 INFO - Successfully installed jsonschema functools32 02:00:21 INFO - Cleaning up... 02:00:21 INFO - Return code: 0 02:00:21 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:00:21 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 0x7f4557a45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x256b600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25fa350>, '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 0x25fb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fb6e0>, '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': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', '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 02:00:21 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 02:00:21 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 02:00:21 INFO - Using env: {'DISPLAY': ':0', 02:00:21 INFO - 'HOME': '/home/cltbld', 02:00:21 INFO - 'LANG': 'en_US.UTF-8', 02:00:21 INFO - 'LANGUAGE': 'en_US:en', 02:00:21 INFO - 'LOGNAME': 'cltbld', 02:00:21 INFO - 'MAIL': '/var/mail/cltbld', 02:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:21 INFO - 'MOZ_NO_REMOTE': '1', 02:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:21 INFO - 'NO_EM_RESTART': '1', 02:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:21 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:21 INFO - 'SHELL': '/bin/bash', 02:00:21 INFO - 'SHLVL': '1', 02:00:21 INFO - 'TERM': 'linux', 02:00:21 INFO - 'TMOUT': '86400', 02:00:21 INFO - 'USER': 'cltbld', 02:00:21 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', 02:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:21 INFO - '_': '/tools/buildbot/bin/python'} 02:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:00:22 INFO - Downloading/unpacking flake8 02:00:22 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 02:00:22 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 02:00:22 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 02:00:22 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 02:00:22 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 02:00:22 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 02:00:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:00:23 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 02:00:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:00:23 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 02:00:23 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 02:00:23 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 02:00:23 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 02:00:23 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 02:00:23 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 02:00:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:00:23 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 02:00:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:00:23 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 02:00:23 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 02:00:23 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 02:00:23 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 02:00:23 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 02:00:23 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 02:00:24 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 02:00:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:00:24 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 02:00:24 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 02:00:24 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 02:00:24 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 02:00:24 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 02:00:24 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 02:00:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 02:00:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:00:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:00:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:00:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:00:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:00:24 INFO - no previously-included directories found matching 'docs/_build' 02:00:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:00:24 INFO - Running setup.py install for pep8 02:00:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:00:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:00:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:00:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:00:24 INFO - no previously-included directories found matching 'docs/_build' 02:00:24 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:00:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:00:24 INFO - Cleaning up... 02:00:24 INFO - Return code: 0 02:00:24 INFO - Running post-action listener: _resource_record_post_action 02:00:24 INFO - Running post-action listener: _start_resource_monitoring 02:00:24 INFO - Starting resource monitoring. 02:00:24 INFO - ##### 02:00:24 INFO - ##### Running install step. 02:00:24 INFO - ##### 02:00:24 INFO - Running pre-action listener: _resource_record_pre_action 02:00:24 INFO - Running main action method: install 02:00:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:00:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:00:24 INFO - Reading from file tmpfile_stdout 02:00:24 INFO - Detecting whether we're running mozinstall >=1.0... 02:00:24 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:00:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:00:24 INFO - Reading from file tmpfile_stdout 02:00:24 INFO - Output received: 02:00:24 INFO - Usage: mozinstall [options] installer 02:00:24 INFO - Options: 02:00:24 INFO - -h, --help show this help message and exit 02:00:24 INFO - -d DEST, --destination=DEST 02:00:24 INFO - Directory to install application into. [default: 02:00:24 INFO - "/builds/slave/test-pgo"] 02:00:24 INFO - --app=APP Application being installed. [default: firefox] 02:00:24 INFO - mkdir: /builds/slave/test-pgo/build/application 02:00:24 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'] 02:00:24 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 02:00:39 INFO - Reading from file tmpfile_stdout 02:00:39 INFO - Output received: 02:00:39 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:00:39 INFO - Running post-action listener: _resource_record_post_action 02:00:39 INFO - ##### 02:00:39 INFO - ##### Running run-tests step. 02:00:39 INFO - ##### 02:00:39 INFO - Running pre-action listener: _resource_record_pre_action 02:00:39 INFO - Running main action method: run_tests 02:00:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:00:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:00:39 INFO - Python 2.7.3 02:00:39 INFO - Return code: 0 02:00:39 INFO - grabbing minidump binary from tooltool 02:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:00:39 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 0x25fa350>, '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 0x25fb250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25fb6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:00:39 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 02:00:39 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 02:00:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:00:39 INFO - Return code: 0 02:00:39 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:00:39 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:00:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:00:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:00:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:00:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:00:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:00:40 INFO - Return code: 0 02:00:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 02:00:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost 02:00:40 INFO - Using env: {'DISPLAY': ':0', 02:00:40 INFO - 'HOME': '/home/cltbld', 02:00:40 INFO - 'LANG': 'en_US.UTF-8', 02:00:40 INFO - 'LANGUAGE': 'en_US:en', 02:00:40 INFO - 'LOGNAME': 'cltbld', 02:00:40 INFO - 'MAIL': '/var/mail/cltbld', 02:00:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:00:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:00:40 INFO - 'MOZ_NO_REMOTE': '1', 02:00:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:00:40 INFO - 'NO_EM_RESTART': '1', 02:00:40 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:00:40 INFO - 'PWD': '/builds/slave/test-pgo', 02:00:40 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:00:40 INFO - 'SHELL': '/bin/bash', 02:00:40 INFO - 'SHLVL': '1', 02:00:40 INFO - 'TERM': 'linux', 02:00:40 INFO - 'TMOUT': '86400', 02:00:40 INFO - 'USER': 'cltbld', 02:00:40 INFO - 'XDG_SESSION_COOKIE': 'd7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690', 02:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:00:40 INFO - '_': '/tools/buildbot/bin/python'} 02:00:40 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost'] with output_timeout 3600 02:00:41 INFO - mozversion INFO | application_buildid: 20151216233005 02:00:41 INFO - mozversion INFO | application_changeset: 1afbb237019de001797d566cd33dd8fa5a9395d1 02:00:41 INFO - mozversion INFO | application_display_name: Nightly 02:00:41 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:00:41 INFO - mozversion INFO | application_name: Firefox 02:00:41 INFO - mozversion INFO | application_remotingname: firefox 02:00:41 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 02:00:41 INFO - mozversion INFO | application_vendor: Mozilla 02:00:41 INFO - mozversion INFO | application_version: 46.0a1 02:00:41 INFO - mozversion INFO | platform_buildid: 20151216233005 02:00:41 INFO - mozversion INFO | platform_changeset: 1afbb237019de001797d566cd33dd8fa5a9395d1 02:00:41 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 02:00:41 INFO - mozversion INFO | platform_version: 46.0a1 02:00:41 INFO - 2015-12-17 02:00:41,031 DEBUG : using testdate: 1450346441 02:00:41 INFO - 2015-12-17 02:00:41,031 DEBUG : actual date: 1450346441 02:00:41 INFO - 2015-12-17 02:00:41,079 INFO : starting webserver on 'localhost:60143' 02:00:41 INFO - 2015-12-17 02:00:41,080 INFO : Starting test suite talos-linux64-ix-068 02:00:41 INFO - 2015-12-17 02:00:41,080 INFO : Starting test dromaeo_css 02:00:41 INFO - 2015-12-17 02:00:41,080 DEBUG : operating with platform_type : linux_ 02:00:41 INFO - 2015-12-17 02:00:41,081 INFO : Initialising browser for dromaeo_css test... 02:00:41 INFO - 2015-12-17 02:00:41,096 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWCw0U3/profile http://localhost:60143/getInfo.html 02:00:45 INFO - 2015-12-17 02:00:45,139 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:00:45 INFO - 2015-12-17 02:00:45,139 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:00:45 INFO - 2015-12-17 02:00:45,140 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:00:45 INFO - 2015-12-17 02:00:45,140 DEBUG : BROWSER_OUTPUT: __metrics 02:00:45 INFO - 2015-12-17 02:00:45,248 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:00:45 INFO - 2015-12-17 02:00:45,304 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:00:46 INFO - 2015-12-17 02:00:46,067 INFO : Browser initialized. 02:00:46 INFO - 2015-12-17 02:00:46,067 INFO : Running cycle 1/1 for dromaeo_css test... 02:00:46 INFO - 2015-12-17 02:00:46,067 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWCw0U3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:00:57 INFO - 2015-12-17 02:00:57,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 142090240 02:00:57 INFO - 2015-12-17 02:00:57,884 DEBUG : BROWSER_OUTPUT: 02:01:48 INFO - 2015-12-17 02:01:48,680 DEBUG : BROWSER_OUTPUT: 1450346508673 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] 02:03:58 INFO - 2015-12-17 02:03:58,666 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60143/tests/dromaeo/cssquery-ext.html) 02:03:59 INFO - 2015-12-17 02:03:59,804 DEBUG : BROWSER_OUTPUT: RSS: Main: 255463424 02:03:59 INFO - 2015-12-17 02:03:59,804 DEBUG : BROWSER_OUTPUT: 02:07:02 INFO - 2015-12-17 02:07:02,262 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/dromaeo/cssquery-ext.html (next: http://localhost:60143/tests/dromaeo/cssquery-jquery.html) 02:07:02 INFO - 2015-12-17 02:07:02,828 DEBUG : BROWSER_OUTPUT: RSS: Main: 229244928 02:07:02 INFO - 2015-12-17 02:07:02,828 DEBUG : BROWSER_OUTPUT: 02:10:04 INFO - 2015-12-17 02:10:04,793 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60143/tests/dromaeo/cssquery-mootools.html) 02:10:05 INFO - 2015-12-17 02:10:05,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 227897344 02:10:05 INFO - 2015-12-17 02:10:05,367 DEBUG : BROWSER_OUTPUT: 02:13:07 INFO - 2015-12-17 02:13:07,306 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60143/tests/dromaeo/cssquery-prototype.html) 02:13:07 INFO - 2015-12-17 02:13:07,900 DEBUG : BROWSER_OUTPUT: RSS: Main: 203890688 02:13:07 INFO - 2015-12-17 02:13:07,900 DEBUG : BROWSER_OUTPUT: 02:16:10 INFO - 2015-12-17 02:16:10,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60143/tests/dromaeo/cssquery-yui.html) 02:16:11 INFO - 2015-12-17 02:16:11,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 206811136 02:16:11 INFO - 2015-12-17 02:16:11,043 DEBUG : BROWSER_OUTPUT: 02:19:13 INFO - 2015-12-17 02:19:13,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/dromaeo/cssquery-yui.html (next: http://localhost:60143/tests/dromaeo/cssquery-dojo.html) 02:19:13 INFO - 2015-12-17 02:19:13,787 DEBUG : BROWSER_OUTPUT: RSS: Main: 267874304 02:19:13 INFO - 2015-12-17 02:19:13,788 DEBUG : BROWSER_OUTPUT: 02:19:13 INFO - 2015-12-17 02:19:13,788 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:19:13 INFO - 2015-12-17 02:19:13,788 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:19:13 INFO - 2015-12-17 02:19:13,788 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:19:13 INFO - 2015-12-17 02:19:13,788 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:19:13 INFO - 2015-12-17 02:19:13,788 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3166.24010237543;3183.952240716388;3225.9838150982437;3227.7579181561387;3252.3495300939803;5234.450382709808;5307.336582927134;5390.811321603745;5434.538064264538;5494.313210848649;5371.5165635092935;5406.378266499354;5452.563794896409;5524.33707955046;5541.556675465963;4948.5298896604945;4984.3021976923255;5020.0712868119335;5067.569256613192;5124.513171248744;5028.120078986181;5045.772940217681;5091.618128640348;5099.643024988252;5110.259012443194;4778.832740854071;4832.275158726184;4886.51134886512;4898.461169271395;4954.9752251238515;4947.257911313296;4952.727599981999;4955.975220123876;4975.651704380694;4999.900001999939;4871.391076115486;4915.680480768774;4928.26076088586;4943.283223932545;4995.100881841267;5110.923336149961;5195.090859099642;5201.193814958688;5208.348956380452;5209.791608335662;5672.886542269172;5673.63121397112;5679.403662615448;5690.260266165414;5691.373948865621;5859.29688437386;5872.765089396462;5872.882542349172;5880.26496687914;5883.8529036774;5392.460753924615;5393.703346315911;5430.67415955044;5460.34475862895;5523.392426833126;5927.436893495111;5953.493953013955;6004.099385092271;6006.399360063959;6027.186329845415;5808.5062769665055;5830.329512106162;5839.678817664984;5889.4699477046415;5890.970545147246;5701.572382071361;5720.1991721159075;5805.564582656318;5819.592628515963;5920.733566989496;5704.71476426177;5712.34308054579;5715.685637289906;5715.914261286084;5762.654240745569;5723.284589426322;5751.13732940054;5751.511121554631;5759.971200144057;5775.306963164363;4360.6729495287345;4373.584509471595;4396.230659634552;4456.532064133284;4484.372187893698;3976.5824588418377;4011.959880401217;4013.13717550728;4037.6366127048705;4061.3704875744306;5303.257543943851;5314.415414304423;5350.411454739976;5385.434529374359;5403.081476149064;5598.048331783607;5722.399148089474;5723.227364305849;5732.856678583069;5806.65160090396;5330.813421530228;5423;5423.403425623178;5439.211314359396;5480.314960629921;5051.747412629354;5066.949330506722;5092.185250359925;5095.87260318495;5119.692818430906;5856.619319744288;5913.881722365614;6041.972864613026;6056.031035034373;6073.939260607426;5800.593958423039;5822.359540450631;5936.614120082181;5941.079132734433;5981.162637230878;5949.286085669747;5953.434423729739;5958.76164953397;5960;5974.9402505974385;5423.674579525241;5520.006398848085;5627.0715331971405;5679.8864022720145;5724.542036636975;5639.520640745583;5666.2350582670815;5775.133729940542;5816.82549523515;5831.1836342912875;5690.487856092972;5790.710464476675;5825.446582574648;5825.79609713658;5831.096180092092;5608.158776183605;5775.9133612995;5793.768249269982;5823.679697616672;5824.330202026821;5489.890202196014;5536.806211782568;5582.665040097607;5637.351704554028;5676.20533125371;5689.971550142388;5743.540516758733;5747.827565173052;5755.1367294906095;5805.8548536286935;5541.418151094077;5638.323401191883;5648.548116150616;5654.773809047592;5661.518770904519 02:19:13 INFO - 2015-12-17 02:19:13,792 DEBUG : BROWSER_OUTPUT: |1;ext.html;545.9543262600226;584.8420926349886;588.0620410445338;588.5968111843387;590.9852253693659;30710.232244193878;38744.806275968615;38918.22163556731;38943.805280973625;38953.610463895355;42622.36066458998;43109;43109.13781724364;43169.78415107928;43172.3524147138;7697.961510192469;7752.069751629812;8796.736097917057;8970.865437018418;8980.146886045815;10618.469076546142;10846.67459976202;10865.185111116698;10868.61959831406;10872.728181795439;10519.63181288655;10621;10623.681289561326;10623.734406639856;10626.62806801762;7972.641231144584;8081.474704144271;10526.473676316193;10655.946720266427;10912.945435272773;10265;10417.635382761642;10424.791504169874;10431.113355364803;10434.37393756377;39226.80386598077;39447.802760986015;39804;39872;39945.80027099875;3284.080457471912;3292.489664102044;3335.0661814691684;3337.1490269981;3341.148007258158;30501.542476862865;30554.84722576373;30669.8466507666;31101.22246943822;31253.687463125305;3929.803509824526;4074;4084.12191378852;4085.060436099684;4116.670666346685;275744;278689;278719.60640196875;279018;281649;52616.736916315174;53945;59851.401485984585;60259;66085.33914660888;58323.70838145782;58438;58857.41142588519;58886;58943.41056589465;15010;15268.541943741706;15343.07941523512;15359.385624574892;15372.154531500652;11388.601398950997;11467.139964502696;11523.884761152449;11534.19260651763;11547.364894930859;19179.566717372112;19393.8060619392;19395.127219275168;19468.61062778765;19490.707639385422;7843.490173138728;7950.204979502004;8117.269445749911;8182.1817818217705;8197.180281971756;928.6053427293373;1008.3143462445607;1019.4087429290994;1031.2523420520063;1128.5147386623667;28665;28897.711022889922;29014.41971160565;29281.85359073191;29453.90733972945;970.815545046439;1042.0881728487573;1049.9475026248656;1084.1326938449208;1154.7979103656826;14648.608382203674;14933.551993440215;15016.47442339513;15148.621284467756;15257.542273731806;320717;325027;327150;327464;328619;52215.73892130591;52729.2090618641;52765;52819.20771188435;52931.470685293425;1326.2970625568464;1337.0707358386023;1340.5241139395569;1341.2824139085737;1353.7292541491545;26771;28194.43611127807;28244.576331354634;32365.352692945537;32979.83510082434;50041.24938125858;50813.74593127011;50858.49141508537;50876.236856447926;50916.49083509117;277837;285660;414693;421153;428445;40868.79565602153;41867.7906610465;41969.160616788104;41985.79007104945;42073.1585368297;45872;45926;46266.76866615645;46614.53385466102;47197.29204061873;37856.24287514179;39363.60636393599;39390.606093938695;41995.7900210497;42750.667698374564;35680.10799729924;36069.63930360663;36222.8188859054;36716.63283367239;37095.62904370922;35619;36304;36332;36354.27291454209;36626.26747465089;31984.520232197003;33147.17132071718;33225.65529068021;33330.16674583155;33551.49672754862;24911.87544062268;25019.624705629067;25028.24915252545;25150.651282845327;25310.367240819127 02:19:13 INFO - 2015-12-17 02:19:13,793 DEBUG : BROWSER_OUTPUT: |2;jquery.html;356.7609701499995;361.887814777419;362.28087246815073;362.92378600493896;364.74285628631816;14161.575152745409;14189.78715319271;16978.49064528063;17525.824741752596;18237.179326930287;14293.14241145532;16554.83445165548;16698.66602667946;17619.82380176201;17625.91187044066;5367.704776237305;5422.6475279106735;5548.140038294051;5552.611317207797;5554.583406244547;4011.2378648056774;4129.359949207877;5463.672179669233;5502.779888804463;5873.676947767871;5925.2889653241455;5947.988841896867;5980.611260268069;5994;6002.699865006754;5803.419658034184;5880.7059647017695;5884.293884733816;5900.291964964189;5902.380250073745;5204.4535323791215;5214;5231.189165679326;5232;5232.084385232569;20800;20974.5805083899;21093.894530527403;21351.466213344636;21397.893010535005;2179.0412218623756;2205.0848897707433;2286.8627882327114;2292.816574674022;2373.2287006722713;12865.485380584765;13382.799258011137;13417.865821341857;13519.932400337935;13632.182069075789;1821.6083542038525;1860.9813901860944;1870.644577530265;1891.6500447417272;1900.8954507502083;59258.40741592572;61205.38794612041;61916.99999999955;62069;62375;9687.079727426024;9806.852897206547;9985.700428987142;10004.149647280063;10077.69766906994;13151.736965260641;13166.144200626928;13210.933945330213;13214.735705286033;13221.140625859289;7237.276272372721;7265.673044713;7272.272772722686;7320.487565870444;7323.853522929511;6673.599584024877;6706.698198581075;6720.462363010947;6886.48351373649;6955.89566156508;5924.851878703067;5958.255218097738;5983.850403739854;5998.730057147439;6012.549058820606;1697.8047524534836;1699.4731633193749;1764.6823571757207;1773.5122841218767;1776.546980519959;935.8455854784021;965.6282331302359;971.6696323250129;1066.9519871605796;1083.4366129612558;17633.118344082744;17726.822731772518;17780.199891004937;17859.46421607354;17973.92156470616;928.9163975242261;963.2631037256505;963.7012526116786;973.2019743810149;993.801239752038;9832.655857044969;10210.642627508001;10245.84631230532;10399.376037437778;10482.528286227138;527655;534256;541104;541447;553269;82315.17684823195;82794;83580;85298.57350713207;86820;1186.703324168975;1191.065013964034;1235.6046065259031;1236.8268442418068;1258.2261908925946;15622;15764.132972686612;15793;15878.444254451038;15902.840971590598;35014.47478287777;35593.288134237686;35957.685077789785;36217.81891090633;36228.456573151954;47036.29445558251;47421;48226.517734822206;50152;50263.74868125782;9648.807023859343;9687.70936871895;9768.462734549668;9830.950845245728;9872.259580531345;17511.124443778015;17878.106094695475;17941.282348706427;18034.098295084932;18242.17910194018;11632.709182270512;11719.824202636797;14130.293485325898;14685.779713304522;14993;14299.928500357848;14405.279736012948;14531.854681453051;14653.92673036628;14918.955673103213;11500.25248358854;12014.33921134346;13233.735325293634;14149.575512734635;15353.923230384224;9293.581788819383;9295.209907157967;9350.43897366133;9508.429494230368;9528.428294302365;10715.517801698787;14033.719325613634;14293.785593215902;14340.784888226894;14442.927785361006 02:19:13 INFO - 2015-12-17 02:19:13,797 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1505.1495904813787;1698.9575260618483;1732.9913350433253;1768.1689605885229;1772.7872655281376;6474.708638111285;7313.26867313269;7467.1039475262905;7476.028116344867;7482.176960534337;7306.305900939402;7497.550146991171;7501.474896757216;7501.624918754054;7502.287282708147;1908.9522761930994;1943.893085880276;1944.7666280046415;2194.5940001099766;2228.142165266376;2172.0334451169238;2220.955580888381;2221.711177546925;2223.144089525528;2225.1321984426086;2109.5780843831217;2159.3198142585034;2194.594000109985;2198.428408613764;2198.8131008864184;1833.9449816505526;1860.5627677495777;1866.8226518480858;1867.7011678131503;2166.9891650541726;2180.8364372672113;2210.5689390568846;2211.734591848988;2216.767239439868;2222.3221917315213;7328.083989501312;7425.405967522639;7428.071491063617;7433.145188303361;7439.3676537494375;4467.664925130595;4574.656900732459;4575.450945886481;4576.267797152473;4583.793729282191;2921.5334080917887;2966.0805150403444;2970.643522777259;2973.7620990320725;2994.505906525421;956.1633570625703;957.0859828863419;959.8560215967591;964.6623681711345;1002.8094662014194;10061.748456288578;10119.291649584533;10133.189344852393;10137.746556336151;10149.543270552844;3969.3450580654444;4010.979945100314;4048.8785336439955;4053.493313335833;4072.063425412172;8690.130986901386;8694.652213911373;8702.34732395073;8704.825903481895;8707.085755995657;4477.104579084196;4501.909961800746;4504.572065653823;4507.076049409863;4507.5267096955;4089.20260549196;4129.648979836687;4131.97934010328;4132.214879172948;4135.60711732385;3544.3442963051916;3549.6627820357025;3570.232400034005;3574.6782789548547;3601.405768048243;1162.4826952006276;1165.7143999720122;1175.7707247086737;1176.805827038546;1184.0586733546852;1264.3741348032784;1290.5289569307135;1293.5601895355624;1303.387407918277;1319.1359659423092;6760.492963027793;7135.750248741269;7256.238095000054;7260.092488438945;7307.1231452226075;1100.8954149355798;1112.3826276416505;1117.201201141188;1122.203235702644;1133.2294040052843;5063.13926632466;5135.768890399941;5635.520980716685;5732.713364331767;5793.159991801165;8596.91403085961;8635.093315201939;8758.2993360531;8878.245349145265;8941.776455588662;8866.512341821262;8966.462012279153;8975;8980.371374003757;8982.877140357456;6898.758543451056;7064.646767661597;7084.504084714124;7097.148342198866;7097.325754053357;6687.364700353459;6828.5220034597105;6857.382835544825;6859.519833611599;6880.759173428906;7765.136367271927;7955.209251210369;7964.522128672298;8037.7588672339925;8050.27547520726;7757;8057.194280571896;8102.027756669002;8102.311303539265;8239.670413183645;7076.7523136692025;7159.069320988238;7167.462440317101;7174.461915356264;7174.533655312388;6928.965355173192;7024.964875175591;7040.718371265092;7048.330408611174;7051.083359163276;6453.870922581428;6554.541182117397;6633.800985970429;6673.399394054559;6770.492213084137;6543.083968244355;6550.377714117151;6566.343365663586;6640.867182656223;6728.091707619605;6596.967015164893;6660.433863121689;6662.966685166543;6664.1003464533605;6664.866702666017;6095.939040609537;6138.785142519991;6152.077188421594;6165.660888651168;6271;6257.593256438499;6308.432241098323;6323.557350985387;6328.082428047999;6333.081703153109 02:19:13 INFO - 2015-12-17 02:19:13,797 DEBUG : BROWSER_OUTPUT: |4;prototype.html;335.1303367760661;340.51646661740324;344.86894979907623;345.06315353814404;345.6077352205246;5740;5865.325487568931;5880.529557635389;5881.735321910508;5883.146943693162;5673.149027645855;5802.738876750545;5814.331351894533;5829.446202610756;5834.620749651281;4567.931481027771;4583;4593.908121837561;4595.977020114895;4603.40155779749;4382.824687012516;4447.822087116528;4503.572160644733;4591.265397536395;4625.329327247547;4506.684532082755;4532.252178390561;4545.681802273843;4562.794674239651;4565.429321334833;4475.395821564096;4481.170983368087;4487.730736155841;4503.48209955856;4571.108633816407;4033.2135233629456;4038.353863381845;4038.9192216155807;4043.6158564936286;4058.512978442606;5495.917561236584;5590.049691552445;5631.63394379364;5638.182463542763;5651.8304450866535;5155.587552995788;5163.612729045337;5215.556677682402;5236.345456817898;5246.003259380744;5887.941120588782;6233.0338797486465;6239.844003899939;6248.625082495065;6250.0624906263965;4232.365145228209;4309.59058889405;4355.716878402894;4379.343098535245;4388.736675799462;6331.968340158316;6371.235451745773;6373.458256048241;6408;6438.25960014595;4453.198424283595;4455.1535208310315;4456.68803183774;4457.509673935864;4477.664175186874;4389.626881715026;4489.438820147481;4523.2988886722615;4534.841280555164;4538.931916021263;5183.118869792144;5223.085959956992;5224.843254702365;5225.137852254412;5229.869253268623;6249.9062514062325;6253.1245625612455;6253.8117757625905;6254.8123556293385;6270.843228919313;1570.2855200883798;1594.3702237616076;1595;1597.193417324267;1598.4405458089575;1068.8022715797601;1070.3684825952569;1075.2097208551709;1077.0575746222055;1092.5575142067476;5934.1692163097205;5941.584089113807;5943.3849106393045;5944.791932282349;5944.7919322824355;6359.427651511386;6361.332060133712;6363.649999249993;6371.5221358397375;6372.865090194744;5930.199423077829;5938.317093534299;5940.524758019348;5944.138099975479;5952.285725712942;3400.6769356911054;3433.3476639438427;3464.6535346465153;3466.0295117367177;3493.737969652286;6612.537122401386;6616.27221005689;6617.43751781104;6763.086983257295;6771;6683.365080317362;6701.6314102723845;6713.12729345182;6713.462922966151;6721.294264102296;6572.539922205399;6734.393904548614;6739.258681545026;6752.155980502437;6765.05289259504;6265.624062556261;6448.290688024407;6525.184351956005;6532.477401807939;6540.803775886731;6329.588576742497;6423.39852359795;6457.063725759833;6472.385123413268;6473.2232132144445;6722.2605513394465;6727.360900714424;6729.798106056826;6735.966320168368;6737.528373013842;4377.737335759864;4483.080968401405;4531.977340113278;4535.138323718483;4538.6369090473345;6382.170317858649;6473.7376211638275;6480.708368123352;6481.805545833632;6486.54594178403;6250.468710159687;6307.90538141919;6315.4947604192475;6317.241930968313;6318.052292156213;6194.132821405097;6248;6278.4035516625845;6287.779927702509;6293.685315734104;6122.020476723703;6147.385261473817;6155.938440615716;6166.136740856194;6169.598976066542;6280.780172693934;6283.120363149072;6293.685315734104;6298.71655775482;6298.937010629835;6044.395560443921;6145.938540614716;6149.72326245329;6152.630842149485;6155.446009859134 02:19:13 INFO - 2015-12-17 02:19:13,800 DEBUG : BROWSER_OUTPUT: |5;yui.html;770.3721467004391;803.2369249213245;820.6389188756942;825.5707032343182;832.6461253967062;13860.514881979132;14061.648458788535;14096.78854817176;14103.57689269321;14172.574822755309;12478.625641230756;12577.622671319852;12587.118901676886;12590.685232869182;12592.118551701384;682.5222344358943;688.6419062087712;814.4380377539509;830.983380332393;833.5998720614109;827.1686954610637;833.0378412933072;836.7196989008689;843.2916350265775;843.3969711656165;862.5557837713551;874.2394117118116;875.4703404440318;875.8861348024748;876.0494863073573;715.0347031507475;721.4805340155079;854.8290341931638;869.217704066339;870.1907226279558;632.1371328137105;636.0554576453962;636.745301879252;637.1971316141695;637.716216283754;13379.799303010463;13433.462661493528;13490.730185396334;13533.729325413437;13616.659583510393;11342.659720208407;11988.760224795455;12889.291088990101;12920.289384083871;13428.798568021488;9957.153641940444;10173.440460774655;10323.122534584569;10901.563937442494;11149.777004459866;3629.6007439181667;3721.1255354991554;3729.9813500932323;3819.694424446038;3831.2912111259507;48975.51024489745;49262;49352;49402.752986235195;49422;10003.949980250198;10385.740356491147;10609;10640.78718425627;10804.13566914645;18976.620467590572;18977.43067707971;18982.430527083932;18986.1456234467;18988.62022759537;7638.312551870247;7732.342750866127;7875.921240787518;7994.389901823268;8150.510969341858;4038.45480860086;4097.303458412077;4119.629233369011;4122.093139509303;4130.834766609362;3012.894548690785;3026.9394612107635;3037;3038.453078445901;3042.6348838139124;535.5849216856967;556.1018954388715;556.471352215397;560.6411896386317;566.2553741829481;555.8249151517259;622.8104320747441;651.501601275025;675.3820254467107;701.529974916807;8621.612027458654;8637.768129477148;8815.338849586307;8855.601497932608;8859;531.580051759106;640.2317219336815;653.7319698923419;677.502036003537;692.9501804765783;3871.535415750128;4050.18996200761;4159.542450330461;4331.285337919271;4345;60463.39536604666;61736.69131654403;61910.0713489298;62202;62569.37430625727;53261.2010819838;54318.45681543213;54963;55750.72124639351;56087;47411.28883066826;47439.762801185774;47698;47807.760961194974;49049.264261036114;8618.827623447622;8777.341699372444;8885.866711999195;9007.459552426875;9159.725208243763;35672.28655426825;36125.81937090403;36165.819170903975;36524.086897827765;36622.26755464823;45974.54025459703;47878;48078.519214807406;48107.27839082346;48959.755201223765;10432.217583681102;10855.131589472665;11023.118150547776;11047.668569942914;11106.777864442827;11319.377434240867;11641.825372619249;11794.469248883992;11876.346800926032;11967.162298639012;11025.117990560897;11208.159388046091;11306.738652269414;11373.374464404536;11778.52885884555;11476.598319058792;11696.473658685209;11895.702607434883;12067.336296503776;12298.323592202514;7948;10439.686809395731;11022.889771102507;11060.502277397376;11061.446927653746;9119.273085554913;9416.435013899189;9420;9586.808263834824;9662.400443792743;8706.695265665672;8891.155340242667;8923.598438070432;9172.6789562365;9226.9538652309 02:19:13 INFO - 2015-12-17 02:19:13,801 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:19:13 INFO - 2015-12-17 02:19:13,801 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:19:13 INFO - 2015-12-17 02:19:13,801 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,874 02:19:13 INFO - 2015-12-17 02:19:13,801 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:19:13 INFO - 2015-12-17 02:19:13,801 DEBUG : BROWSER_OUTPUT: __startTimestamp1450347553785__endTimestamp 02:19:13 INFO - 2015-12-17 02:19:13,801 DEBUG : BROWSER_OUTPUT: 02:19:13 INFO - 2015-12-17 02:19:13,801 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:19:13 INFO - 2015-12-17 02:19:13,801 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:19:13 INFO - 2015-12-17 02:19:13,801 DEBUG : BROWSER_OUTPUT: 02:19:13 INFO - 2015-12-17 02:19:13,801 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5391.21 Median:5608.16 stddev:598.21 (10.7%) stddev-sans-first:574.01 02:19:13 INFO - 2015-12-17 02:19:13,802 DEBUG : BROWSER_OUTPUT: Values: 3166.2 3184.0 3226.0 3227.8 3252.3 5234.5 5307.3 5390.8 5434.5 5494.3 5371.5 5406.4 5452.6 5524.3 5541.6 4948.5 4984.3 5020.1 5067.6 5124.5 5028.1 5045.8 5091.6 5099.6 5110.3 4778.8 4832.3 4886.5 4898.5 4955.0 4947.3 4952.7 4956.0 4975.7 4999.9 4871.4 4915.7 4928.3 4943.3 4995.1 5110.9 5195.1 5201.2 5208.3 5209.8 5672.9 5673.6 5679.4 5690.3 5691.4 5859.3 5872.8 5872.9 5880.3 5883.9 5392.5 5393.7 5430.7 5460.3 5523.4 5927.4 5953.5 6004.1 6006.4 6027.2 5808.5 5830.3 5839.7 5889.5 5891.0 5701.6 5720.2 5805.6 5819.6 5920.7 5704.7 5712.3 5715.7 5715.9 5762.7 5723.3 5751.1 5751.5 5760.0 5775.3 4360.7 4373.6 4396.2 4456.5 4484.4 3976.6 4012.0 4013.1 4037.6 4061.4 5303.3 5314.4 5350.4 5385.4 5403.1 5598.0 5722.4 5723.2 5732.9 5806.7 5330.8 5423.0 5423.4 5439.2 5480.3 5051.7 5066.9 5092.2 5095.9 5119.7 5856.6 5913.9 6042.0 6056.0 6073.9 5800.6 5822.4 5936.6 5941.1 5981.2 5949.3 5953.4 5958.8 5960.0 5974.9 5423.7 5520.0 5627.1 5679.9 5724.5 5639.5 5666.2 5775.1 5816.8 5831.2 5690.5 5790.7 5825.4 5825.8 5831.1 5608.2 5775.9 5793.8 5823.7 5824.3 5489.9 5536.8 5582.7 5637.4 5676.2 5690.0 5743.5 5747.8 5755.1 5805.9 5541.4 5638.3 5648.5 5654.8 5661.5 02:19:13 INFO - 2015-12-17 02:19:13,802 DEBUG : BROWSER_OUTPUT: 02:19:13 INFO - 2015-12-17 02:19:13,802 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49719.30 Median:3336.11 stddev:85939.65 (2576.0%) stddev-sans-first:86101.43 02:19:13 INFO - 2015-12-17 02:19:13,802 DEBUG : BROWSER_OUTPUT: Values: 546.0 584.8 588.1 588.6 591.0 30710.2 38744.8 38918.2 38943.8 38953.6 42622.4 43109.0 43109.1 43169.8 43172.4 7698.0 7752.1 8796.7 8970.9 8980.1 10618.5 10846.7 10865.2 10868.6 10872.7 10519.6 10621.0 10623.7 10623.7 10626.6 7972.6 8081.5 10526.5 10655.9 10912.9 10265.0 10417.6 10424.8 10431.1 10434.4 39226.8 39447.8 39804.0 39872.0 39945.8 3284.1 3292.5 3335.1 3337.1 3341.1 30501.5 30554.8 30669.8 31101.2 31253.7 3929.8 4074.0 4084.1 4085.1 4116.7 275744.0 278689.0 278719.6 279018.0 281649.0 52616.7 53945.0 59851.4 60259.0 66085.3 58323.7 58438.0 58857.4 58886.0 58943.4 15010.0 15268.5 15343.1 15359.4 15372.2 11388.6 11467.1 11523.9 11534.2 11547.4 19179.6 19393.8 19395.1 19468.6 19490.7 7843.5 7950.2 8117.3 8182.2 8197.2 928.6 1008.3 1019.4 1031.3 1128.5 28665.0 28897.7 29014.4 29281.9 29453.9 970.8 1042.1 1049.9 1084.1 1154.8 14648.6 14933.6 15016.5 15148.6 15257.5 320717.0 325027.0 327150.0 327464.0 328619.0 52215.7 52729.2 52765.0 52819.2 52931.5 1326.3 1337.1 1340.5 1341.3 1353.7 26771.0 28194.4 28244.6 32365.4 32979.8 50041.2 50813.7 50858.5 50876.2 50916.5 277837.0 285660.0 414693.0 421153.0 428445.0 40868.8 41867.8 41969.2 41985.8 42073.2 45872.0 45926.0 46266.8 46614.5 47197.3 37856.2 39363.6 39390.6 41995.8 42750.7 35680.1 36069.6 36222.8 36716.6 37095.6 35619.0 36304.0 36332.0 36354.3 36626.3 31984.5 33147.2 33225.7 33330.2 33551.5 24911.9 25019.6 25028.2 25150.7 25310.4 02:19:13 INFO - 2015-12-17 02:19:13,802 DEBUG : BROWSER_OUTPUT: 02:19:13 INFO - 2015-12-17 02:19:13,802 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29239.05 Median:18157.22 stddev:88213.54 (485.8%) stddev-sans-first:88434.34 02:19:13 INFO - 2015-12-17 02:19:13,803 DEBUG : BROWSER_OUTPUT: Values: 356.8 361.9 362.3 362.9 364.7 14161.6 14189.8 16978.5 17525.8 18237.2 14293.1 16554.8 16698.7 17619.8 17625.9 5367.7 5422.6 5548.1 5552.6 5554.6 4011.2 4129.4 5463.7 5502.8 5873.7 5925.3 5948.0 5980.6 5994.0 6002.7 5803.4 5880.7 5884.3 5900.3 5902.4 5204.5 5214.0 5231.2 5232.0 5232.1 20800.0 20974.6 21093.9 21351.5 21397.9 2179.0 2205.1 2286.9 2292.8 2373.2 12865.5 13382.8 13417.9 13519.9 13632.2 1821.6 1861.0 1870.6 1891.7 1900.9 59258.4 61205.4 61917.0 62069.0 62375.0 9687.1 9806.9 9985.7 10004.1 10077.7 13151.7 13166.1 13210.9 13214.7 13221.1 7237.3 7265.7 7272.3 7320.5 7323.9 6673.6 6706.7 6720.5 6886.5 6955.9 5924.9 5958.3 5983.9 5998.7 6012.5 1697.8 1699.5 1764.7 1773.5 1776.5 935.8 965.6 971.7 1067.0 1083.4 17633.1 17726.8 17780.2 17859.5 17973.9 928.9 963.3 963.7 973.2 993.8 9832.7 10210.6 10245.8 10399.4 10482.5 527655.0 534256.0 541104.0 541447.0 553269.0 82315.2 82794.0 83580.0 85298.6 86820.0 1186.7 1191.1 1235.6 1236.8 1258.2 15622.0 15764.1 15793.0 15878.4 15902.8 35014.5 35593.3 35957.7 36217.8 36228.5 47036.3 47421.0 48226.5 50152.0 50263.7 9648.8 9687.7 9768.5 9831.0 9872.3 17511.1 17878.1 17941.3 18034.1 18242.2 11632.7 11719.8 14130.3 14685.8 14993.0 14299.9 14405.3 14531.9 14653.9 14919.0 11500.3 12014.3 13233.7 14149.6 15353.9 9293.6 9295.2 9350.4 9508.4 9528.4 10715.5 14033.7 14293.8 14340.8 14442.9 02:19:13 INFO - 2015-12-17 02:19:13,803 DEBUG : BROWSER_OUTPUT: 02:19:13 INFO - 2015-12-17 02:19:13,804 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5228.05 Median:6264.30 stddev:2674.08 (42.7%) stddev-sans-first:2666.95 02:19:13 INFO - 2015-12-17 02:19:13,804 DEBUG : BROWSER_OUTPUT: Values: 1505.1 1699.0 1733.0 1768.2 1772.8 6474.7 7313.3 7467.1 7476.0 7482.2 7306.3 7497.6 7501.5 7501.6 7502.3 1909.0 1943.9 1944.8 2194.6 2228.1 2172.0 2221.0 2221.7 2223.1 2225.1 2109.6 2159.3 2194.6 2198.4 2198.8 1833.9 1860.6 1866.8 1867.7 2167.0 2180.8 2210.6 2211.7 2216.8 2222.3 7328.1 7425.4 7428.1 7433.1 7439.4 4467.7 4574.7 4575.5 4576.3 4583.8 2921.5 2966.1 2970.6 2973.8 2994.5 956.2 957.1 959.9 964.7 1002.8 10061.7 10119.3 10133.2 10137.7 10149.5 3969.3 4011.0 4048.9 4053.5 4072.1 8690.1 8694.7 8702.3 8704.8 8707.1 4477.1 4501.9 4504.6 4507.1 4507.5 4089.2 4129.6 4132.0 4132.2 4135.6 3544.3 3549.7 3570.2 3574.7 3601.4 1162.5 1165.7 1175.8 1176.8 1184.1 1264.4 1290.5 1293.6 1303.4 1319.1 6760.5 7135.8 7256.2 7260.1 7307.1 1100.9 1112.4 1117.2 1122.2 1133.2 5063.1 5135.8 5635.5 5732.7 5793.2 8596.9 8635.1 8758.3 8878.2 8941.8 8866.5 8966.5 8975.0 8980.4 8982.9 6898.8 7064.6 7084.5 7097.1 7097.3 6687.4 6828.5 6857.4 6859.5 6880.8 7765.1 7955.2 7964.5 8037.8 8050.3 7757.0 8057.2 8102.0 8102.3 8239.7 7076.8 7159.1 7167.5 7174.5 7174.5 6929.0 7025.0 7040.7 7048.3 7051.1 6453.9 6554.5 6633.8 6673.4 6770.5 6543.1 6550.4 6566.3 6640.9 6728.1 6597.0 6660.4 6663.0 6664.1 6664.9 6095.9 6138.8 6152.1 6165.7 6271.0 6257.6 6308.4 6323.6 6328.1 6333.1 02:19:13 INFO - 2015-12-17 02:19:13,804 DEBUG : BROWSER_OUTPUT: 02:19:13 INFO - 2015-12-17 02:19:13,804 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5235.33 Median:5909.07 stddev:1568.33 (26.5%) stddev-sans-first:1528.99 02:19:13 INFO - 2015-12-17 02:19:13,805 DEBUG : BROWSER_OUTPUT: Values: 335.1 340.5 344.9 345.1 345.6 5740.0 5865.3 5880.5 5881.7 5883.1 5673.1 5802.7 5814.3 5829.4 5834.6 4567.9 4583.0 4593.9 4596.0 4603.4 4382.8 4447.8 4503.6 4591.3 4625.3 4506.7 4532.3 4545.7 4562.8 4565.4 4475.4 4481.2 4487.7 4503.5 4571.1 4033.2 4038.4 4038.9 4043.6 4058.5 5495.9 5590.0 5631.6 5638.2 5651.8 5155.6 5163.6 5215.6 5236.3 5246.0 5887.9 6233.0 6239.8 6248.6 6250.1 4232.4 4309.6 4355.7 4379.3 4388.7 6332.0 6371.2 6373.5 6408.0 6438.3 4453.2 4455.2 4456.7 4457.5 4477.7 4389.6 4489.4 4523.3 4534.8 4538.9 5183.1 5223.1 5224.8 5225.1 5229.9 6249.9 6253.1 6253.8 6254.8 6270.8 1570.3 1594.4 1595.0 1597.2 1598.4 1068.8 1070.4 1075.2 1077.1 1092.6 5934.2 5941.6 5943.4 5944.8 5944.8 6359.4 6361.3 6363.6 6371.5 6372.9 5930.2 5938.3 5940.5 5944.1 5952.3 3400.7 3433.3 3464.7 3466.0 3493.7 6612.5 6616.3 6617.4 6763.1 6771.0 6683.4 6701.6 6713.1 6713.5 6721.3 6572.5 6734.4 6739.3 6752.2 6765.1 6265.6 6448.3 6525.2 6532.5 6540.8 6329.6 6423.4 6457.1 6472.4 6473.2 6722.3 6727.4 6729.8 6736.0 6737.5 4377.7 4483.1 4532.0 4535.1 4538.6 6382.2 6473.7 6480.7 6481.8 6486.5 6250.5 6307.9 6315.5 6317.2 6318.1 6194.1 6248.0 6278.4 6287.8 6293.7 6122.0 6147.4 6155.9 6166.1 6169.6 6280.8 6283.1 6293.7 6298.7 6298.9 6044.4 6145.9 6149.7 6152.6 6155.4 02:19:13 INFO - 2015-12-17 02:19:13,805 DEBUG : BROWSER_OUTPUT: 02:19:13 INFO - 2015-12-17 02:19:13,805 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14225.94 Median:48533.52 stddev:16898.33 (34.8%) stddev-sans-first:16915.52 02:19:13 INFO - 2015-12-17 02:19:13,806 DEBUG : BROWSER_OUTPUT: Values: 770.4 803.2 820.6 825.6 832.6 13860.5 14061.6 14096.8 14103.6 14172.6 12478.6 12577.6 12587.1 12590.7 12592.1 682.5 688.6 814.4 831.0 833.6 827.2 833.0 836.7 843.3 843.4 862.6 874.2 875.5 875.9 876.0 715.0 721.5 854.8 869.2 870.2 632.1 636.1 636.7 637.2 637.7 13379.8 13433.5 13490.7 13533.7 13616.7 11342.7 11988.8 12889.3 12920.3 13428.8 9957.2 10173.4 10323.1 10901.6 11149.8 3629.6 3721.1 3730.0 3819.7 3831.3 48975.5 49262.0 49352.0 49402.8 49422.0 10003.9 10385.7 10609.0 10640.8 10804.1 18976.6 18977.4 18982.4 18986.1 18988.6 7638.3 7732.3 7875.9 7994.4 8150.5 4038.5 4097.3 4119.6 4122.1 4130.8 3012.9 3026.9 3037.0 3038.5 3042.6 535.6 556.1 556.5 560.6 566.3 555.8 622.8 651.5 675.4 701.5 8621.6 8637.8 8815.3 8855.6 8859.0 531.6 640.2 653.7 677.5 693.0 3871.5 4050.2 4159.5 4331.3 4345.0 60463.4 61736.7 61910.1 62202.0 62569.4 53261.2 54318.5 54963.0 55750.7 56087.0 47411.3 47439.8 47698.0 47807.8 49049.3 8618.8 8777.3 8885.9 9007.5 9159.7 35672.3 36125.8 36165.8 36524.1 36622.3 45974.5 47878.0 48078.5 48107.3 48959.8 10432.2 10855.1 11023.1 11047.7 11106.8 11319.4 11641.8 11794.5 11876.3 11967.2 11025.1 11208.2 11306.7 11373.4 11778.5 11476.6 11696.5 11895.7 12067.3 12298.3 7948.0 10439.7 11022.9 11060.5 11061.4 9119.3 9416.4 9420.0 9586.8 9662.4 8706.7 8891.2 8923.6 9172.7 9227.0 02:19:13 INFO - 2015-12-17 02:19:13,806 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:19:13 INFO - 2015-12-17 02:19:13,806 DEBUG : BROWSER_OUTPUT: 02:19:14 INFO - 2015-12-17 02:19:14,519 INFO : Browser exited with error code: 0 02:19:14 INFO - 2015-12-17 02:19:14,540 INFO : Completed test dromaeo_css (00:18:33) 02:19:14 INFO - 2015-12-17 02:19:14,540 INFO : Starting test kraken 02:19:14 INFO - 2015-12-17 02:19:14,540 DEBUG : operating with platform_type : linux_ 02:19:14 INFO - 2015-12-17 02:19:14,540 INFO : Initialising browser for kraken test... 02:19:14 INFO - 2015-12-17 02:19:14,546 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnoZVc4/profile http://localhost:60143/getInfo.html 02:19:18 INFO - 2015-12-17 02:19:18,602 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:19:18 INFO - 2015-12-17 02:19:18,603 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:19:18 INFO - 2015-12-17 02:19:18,603 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:19:18 INFO - 2015-12-17 02:19:18,603 DEBUG : BROWSER_OUTPUT: __metrics 02:19:18 INFO - 2015-12-17 02:19:18,691 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:19:18 INFO - 2015-12-17 02:19:18,747 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:19:19 INFO - 2015-12-17 02:19:19,551 INFO : Browser initialized. 02:19:19 INFO - 2015-12-17 02:19:19,552 INFO : Running cycle 1/1 for kraken test... 02:19:19 INFO - 2015-12-17 02:19:19,552 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnoZVc4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:19:31 INFO - 2015-12-17 02:19:31,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 142643200 02:19:31 INFO - 2015-12-17 02:19:31,388 DEBUG : BROWSER_OUTPUT: 02:19:33 INFO - 2015-12-17 02:19:33,876 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60143/tests/kraken/driver.html?testName=audio-beat-detection) 02:19:34 INFO - 2015-12-17 02:19:34,469 DEBUG : BROWSER_OUTPUT: RSS: Main: 177987584 02:19:34 INFO - 2015-12-17 02:19:34,469 DEBUG : BROWSER_OUTPUT: 02:19:37 INFO - 2015-12-17 02:19:37,071 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60143/tests/kraken/driver.html?testName=audio-dft) 02:19:37 INFO - 2015-12-17 02:19:37,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 167006208 02:19:37 INFO - 2015-12-17 02:19:37,644 DEBUG : BROWSER_OUTPUT: 02:19:40 INFO - 2015-12-17 02:19:40,589 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60143/tests/kraken/driver.html?testName=audio-fft) 02:19:41 INFO - 2015-12-17 02:19:41,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 152760320 02:19:41 INFO - 2015-12-17 02:19:41,151 DEBUG : BROWSER_OUTPUT: 02:19:43 INFO - 2015-12-17 02:19:43,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60143/tests/kraken/driver.html?testName=audio-oscillator) 02:19:43 INFO - 2015-12-17 02:19:43,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 155279360 02:19:43 INFO - 2015-12-17 02:19:43,716 DEBUG : BROWSER_OUTPUT: 02:19:45 INFO - 2015-12-17 02:19:45,902 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60143/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:19:46 INFO - 2015-12-17 02:19:46,468 DEBUG : BROWSER_OUTPUT: RSS: Main: 158154752 02:19:46 INFO - 2015-12-17 02:19:46,468 DEBUG : BROWSER_OUTPUT: 02:19:49 INFO - 2015-12-17 02:19:49,372 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60143/tests/kraken/driver.html?testName=imaging-darkroom) 02:19:49 INFO - 2015-12-17 02:19:49,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 156299264 02:19:49 INFO - 2015-12-17 02:19:49,945 DEBUG : BROWSER_OUTPUT: 02:19:53 INFO - 2015-12-17 02:19:53,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60143/tests/kraken/driver.html?testName=imaging-desaturate) 02:19:53 INFO - 2015-12-17 02:19:53,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 159444992 02:19:53 INFO - 2015-12-17 02:19:53,873 DEBUG : BROWSER_OUTPUT: 02:19:56 INFO - 2015-12-17 02:19:56,631 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60143/tests/kraken/driver.html?testName=json-parse-financial) 02:19:57 INFO - 2015-12-17 02:19:57,213 DEBUG : BROWSER_OUTPUT: RSS: Main: 159199232 02:19:57 INFO - 2015-12-17 02:19:57,213 DEBUG : BROWSER_OUTPUT: 02:19:58 INFO - 2015-12-17 02:19:58,807 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60143/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:19:59 INFO - 2015-12-17 02:19:59,368 DEBUG : BROWSER_OUTPUT: RSS: Main: 166121472 02:19:59 INFO - 2015-12-17 02:19:59,368 DEBUG : BROWSER_OUTPUT: 02:20:01 INFO - 2015-12-17 02:20:01,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60143/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:20:01 INFO - 2015-12-17 02:20:01,777 DEBUG : BROWSER_OUTPUT: RSS: Main: 164524032 02:20:01 INFO - 2015-12-17 02:20:01,777 DEBUG : BROWSER_OUTPUT: 02:20:03 INFO - 2015-12-17 02:20:03,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60143/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:20:04 INFO - 2015-12-17 02:20:04,415 DEBUG : BROWSER_OUTPUT: RSS: Main: 173948928 02:20:04 INFO - 2015-12-17 02:20:04,416 DEBUG : BROWSER_OUTPUT: 02:20:06 INFO - 2015-12-17 02:20:06,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:20:07 INFO - 2015-12-17 02:20:07,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 183771136 02:20:07 INFO - 2015-12-17 02:20:07,412 DEBUG : BROWSER_OUTPUT: 02:20:09 INFO - 2015-12-17 02:20:09,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:20:10 INFO - 2015-12-17 02:20:10,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 180326400 02:20:10 INFO - 2015-12-17 02:20:10,561 DEBUG : BROWSER_OUTPUT: 02:20:12 INFO - 2015-12-17 02:20:12,275 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60143/tests/kraken/driver.html?testName=ai-astar) 02:20:12 INFO - 2015-12-17 02:20:12,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 238559232 02:20:12 INFO - 2015-12-17 02:20:12,534 DEBUG : BROWSER_OUTPUT: 02:20:12 INFO - 2015-12-17 02:20:12,534 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:20:12 INFO - 2015-12-17 02:20:12,534 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:20:12 INFO - 2015-12-17 02:20:12,534 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:20:12 INFO - 2015-12-17 02:20:12,534 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:20:12 INFO - 2015-12-17 02:20:12,534 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;111;106;109;113;110;101;111;111;111 02:20:12 INFO - 2015-12-17 02:20:12,534 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;122;154;166;126;151;147;126;162;124 02:20:12 INFO - 2015-12-17 02:20:12,534 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;162;160;162;160;162;166;162;163 02:20:12 INFO - 2015-12-17 02:20:12,534 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;81;94;74;79;72;119;98;74 02:20:12 INFO - 2015-12-17 02:20:12,534 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;142;93;93;93;138;92;92;132 02:20:12 INFO - 2015-12-17 02:20:12,535 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;109;109;110;110;109;110 02:20:12 INFO - 2015-12-17 02:20:12,535 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;146;147;147;148;146;146;147 02:20:12 INFO - 2015-12-17 02:20:12,535 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;95;96;95;96;96;96;95 02:20:12 INFO - 2015-12-17 02:20:12,535 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;58;59;58;60;57;57;66;56;56 02:20:12 INFO - 2015-12-17 02:20:12,535 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;68;68;68;69;68;69;68 02:20:12 INFO - 2015-12-17 02:20:12,535 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;86;85;86;84;95;84;93;86;86 02:20:12 INFO - 2015-12-17 02:20:12,535 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;121;122;121;126;119;123;114;118;119 02:20:12 INFO - 2015-12-17 02:20:12,535 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;142;151;154;152;153;141;163;152;143;143 02:20:12 INFO - 2015-12-17 02:20:12,535 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;70;70;70;68;69;67;68;68;68 02:20:12 INFO - 2015-12-17 02:20:12,535 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:20:12 INFO - 2015-12-17 02:20:12,535 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:20:12 INFO - 2015-12-17 02:20:12,535 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,958 02:20:12 INFO - 2015-12-17 02:20:12,536 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:20:12 INFO - 2015-12-17 02:20:12,536 DEBUG : BROWSER_OUTPUT: __startTimestamp1450347612529__endTimestamp 02:20:12 INFO - 2015-12-17 02:20:12,536 DEBUG : BROWSER_OUTPUT: 02:20:12 INFO - 2015-12-17 02:20:12,536 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:20:12 INFO - 2015-12-17 02:20:12,536 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:20:12 INFO - 2015-12-17 02:20:12,536 DEBUG : BROWSER_OUTPUT: 02:20:12 INFO - 2015-12-17 02:20:12,536 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.20 Median:111.00 stddev:3.43 (3.1%) stddev-sans-first:3.63 02:20:12 INFO - 2015-12-17 02:20:12,536 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 106.0 109.0 113.0 110.0 101.0 111.0 111.0 111.0 02:20:12 INFO - 2015-12-17 02:20:12,537 DEBUG : BROWSER_OUTPUT: 02:20:12 INFO - 2015-12-17 02:20:12,537 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.70 Median:150.00 stddev:16.69 (11.1%) stddev-sans-first:17.54 02:20:12 INFO - 2015-12-17 02:20:12,537 DEBUG : BROWSER_OUTPUT: Values: 149.0 122.0 154.0 166.0 126.0 151.0 147.0 126.0 162.0 124.0 02:20:12 INFO - 2015-12-17 02:20:12,537 DEBUG : BROWSER_OUTPUT: 02:20:12 INFO - 2015-12-17 02:20:12,537 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.81 (1.1%) stddev-sans-first:1.80 02:20:12 INFO - 2015-12-17 02:20:12,537 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 162.0 160.0 162.0 160.0 162.0 166.0 162.0 163.0 02:20:12 INFO - 2015-12-17 02:20:12,537 DEBUG : BROWSER_OUTPUT: 02:20:12 INFO - 2015-12-17 02:20:12,537 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.70 Median:76.50 stddev:15.43 (20.2%) stddev-sans-first:15.77 02:20:12 INFO - 2015-12-17 02:20:12,537 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 81.0 94.0 74.0 79.0 72.0 119.0 98.0 74.0 02:20:12 INFO - 2015-12-17 02:20:12,537 DEBUG : BROWSER_OUTPUT: 02:20:12 INFO - 2015-12-17 02:20:12,537 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:93.00 stddev:21.69 (23.3%) stddev-sans-first:22.48 02:20:12 INFO - 2015-12-17 02:20:12,537 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 142.0 93.0 93.0 93.0 138.0 92.0 92.0 132.0 02:20:12 INFO - 2015-12-17 02:20:12,537 DEBUG : BROWSER_OUTPUT: 02:20:12 INFO - 2015-12-17 02:20:12,537 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:20:12 INFO - 2015-12-17 02:20:12,537 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 109.0 109.0 110.0 110.0 109.0 110.0 02:20:12 INFO - 2015-12-17 02:20:12,537 DEBUG : BROWSER_OUTPUT: 02:20:12 INFO - 2015-12-17 02:20:12,538 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 02:20:12 INFO - 2015-12-17 02:20:12,538 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 146.0 147.0 147.0 148.0 146.0 146.0 147.0 02:20:12 INFO - 2015-12-17 02:20:12,538 DEBUG : BROWSER_OUTPUT: 02:20:12 INFO - 2015-12-17 02:20:12,538 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:20:12 INFO - 2015-12-17 02:20:12,538 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 95.0 02:20:12 INFO - 2015-12-17 02:20:12,538 DEBUG : BROWSER_OUTPUT: 02:20:12 INFO - 2015-12-17 02:20:12,538 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.50 stddev:2.91 (5.0%) stddev-sans-first:3.09 02:20:12 INFO - 2015-12-17 02:20:12,538 DEBUG : BROWSER_OUTPUT: Values: 59.0 58.0 59.0 58.0 60.0 57.0 57.0 66.0 56.0 56.0 02:20:12 INFO - 2015-12-17 02:20:12,538 DEBUG : BROWSER_OUTPUT: 02:20:12 INFO - 2015-12-17 02:20:12,538 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 02:20:12 INFO - 2015-12-17 02:20:12,538 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 68.0 68.0 68.0 69.0 68.0 69.0 68.0 02:20:12 INFO - 2015-12-17 02:20:12,538 DEBUG : BROWSER_OUTPUT: 02:20:12 INFO - 2015-12-17 02:20:12,538 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:86.00 stddev:3.80 (4.4%) stddev-sans-first:3.96 02:20:12 INFO - 2015-12-17 02:20:12,538 DEBUG : BROWSER_OUTPUT: Values: 85.0 86.0 85.0 86.0 84.0 95.0 84.0 93.0 86.0 86.0 02:20:12 INFO - 2015-12-17 02:20:12,538 DEBUG : BROWSER_OUTPUT: 02:20:12 INFO - 2015-12-17 02:20:12,538 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.70 Median:121.50 stddev:3.40 (2.8%) stddev-sans-first:3.39 02:20:12 INFO - 2015-12-17 02:20:12,539 DEBUG : BROWSER_OUTPUT: Values: 124.0 121.0 122.0 121.0 126.0 119.0 123.0 114.0 118.0 119.0 02:20:12 INFO - 2015-12-17 02:20:12,539 DEBUG : BROWSER_OUTPUT: 02:20:12 INFO - 2015-12-17 02:20:12,539 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:152.00 stddev:7.01 (4.6%) stddev-sans-first:6.91 02:20:12 INFO - 2015-12-17 02:20:12,539 DEBUG : BROWSER_OUTPUT: Values: 142.0 151.0 154.0 152.0 153.0 141.0 163.0 152.0 143.0 143.0 02:20:12 INFO - 2015-12-17 02:20:12,539 DEBUG : BROWSER_OUTPUT: 02:20:12 INFO - 2015-12-17 02:20:12,539 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.50 stddev:1.07 (1.6%) stddev-sans-first:1.12 02:20:12 INFO - 2015-12-17 02:20:12,539 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 70.0 70.0 68.0 69.0 67.0 68.0 68.0 68.0 02:20:12 INFO - 2015-12-17 02:20:12,539 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:20:12 INFO - 2015-12-17 02:20:12,539 DEBUG : BROWSER_OUTPUT: 02:20:13 INFO - 2015-12-17 02:20:13,379 INFO : Browser exited with error code: 0 02:20:13 INFO - 2015-12-17 02:20:13,433 INFO : Completed test kraken (00:00:58) 02:20:13 INFO - 2015-12-17 02:20:13,433 INFO : Starting test v8_7 02:20:13 INFO - 2015-12-17 02:20:13,433 DEBUG : operating with platform_type : linux_ 02:20:13 INFO - 2015-12-17 02:20:13,434 INFO : Initialising browser for v8_7 test... 02:20:13 INFO - 2015-12-17 02:20:13,440 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWEolf1/profile http://localhost:60143/getInfo.html 02:20:17 INFO - 2015-12-17 02:20:17,495 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:20:17 INFO - 2015-12-17 02:20:17,495 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:20:17 INFO - 2015-12-17 02:20:17,495 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:20:17 INFO - 2015-12-17 02:20:17,495 DEBUG : BROWSER_OUTPUT: __metrics 02:20:17 INFO - 2015-12-17 02:20:17,580 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 02:20:17 INFO - 2015-12-17 02:20:17,628 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:20:18 INFO - 2015-12-17 02:20:18,411 INFO : Browser initialized. 02:20:18 INFO - 2015-12-17 02:20:18,411 INFO : Running cycle 1/1 for v8_7 test... 02:20:18 INFO - 2015-12-17 02:20:18,411 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWEolf1/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:20:30 INFO - 2015-12-17 02:20:30,250 DEBUG : BROWSER_OUTPUT: RSS: Main: 142331904 02:20:30 INFO - 2015-12-17 02:20:30,251 DEBUG : BROWSER_OUTPUT: 02:20:51 INFO - 2015-12-17 02:20:51,658 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:60143/tests/v8_7/run.html (next: http://localhost:60143/tests/v8_7/run.html) 02:20:51 INFO - 2015-12-17 02:20:51,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 605630464 02:20:51 INFO - 2015-12-17 02:20:51,908 DEBUG : BROWSER_OUTPUT: 02:20:51 INFO - 2015-12-17 02:20:51,910 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:20:51 INFO - 2015-12-17 02:20:51,910 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:20:51 INFO - 2015-12-17 02:20:51,910 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:20:51 INFO - 2015-12-17 02:20:51,910 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:20:51 INFO - 2015-12-17 02:20:51,910 DEBUG : BROWSER_OUTPUT: |0;Richards;165.53550736633008 02:20:51 INFO - 2015-12-17 02:20:51,910 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.78610534264678 02:20:51 INFO - 2015-12-17 02:20:51,911 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.72027972027973 02:20:51 INFO - 2015-12-17 02:20:51,911 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 02:20:51 INFO - 2015-12-17 02:20:51,911 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1968.5039370078741 02:20:51 INFO - 2015-12-17 02:20:51,911 DEBUG : BROWSER_OUTPUT: |5;Earley;788.6435331230284 02:20:51 INFO - 2015-12-17 02:20:51,911 DEBUG : BROWSER_OUTPUT: |6;Boyer;12708.860759493671 02:20:51 INFO - 2015-12-17 02:20:51,911 DEBUG : BROWSER_OUTPUT: |7;RegExp;25425 02:20:51 INFO - 2015-12-17 02:20:51,912 DEBUG : BROWSER_OUTPUT: |8;Splay;677.0480704129993 02:20:51 INFO - 2015-12-17 02:20:51,912 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 02:20:51 INFO - 2015-12-17 02:20:51,912 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:20:51 INFO - 2015-12-17 02:20:51,912 DEBUG : BROWSER_OUTPUT: __startTimestamp1450347651909__endTimestamp 02:20:51 INFO - 2015-12-17 02:20:51,912 DEBUG : BROWSER_OUTPUT: 02:20:51 INFO - 2015-12-17 02:20:51,913 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:20:51 INFO - 2015-12-17 02:20:51,913 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:20:51 INFO - 2015-12-17 02:20:51,913 DEBUG : BROWSER_OUTPUT: 02:20:51 INFO - 2015-12-17 02:20:51,913 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.54 Median:165.54 stddev:0.00 (0.0%) 02:20:51 INFO - 2015-12-17 02:20:51,913 DEBUG : BROWSER_OUTPUT: Values: 165.5 02:20:51 INFO - 2015-12-17 02:20:51,914 DEBUG : BROWSER_OUTPUT: 02:20:51 INFO - 2015-12-17 02:20:51,914 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.79 Median:188.79 stddev:0.00 (0.0%) 02:20:51 INFO - 2015-12-17 02:20:51,914 DEBUG : BROWSER_OUTPUT: Values: 188.8 02:20:51 INFO - 2015-12-17 02:20:51,914 DEBUG : BROWSER_OUTPUT: 02:20:51 INFO - 2015-12-17 02:20:51,914 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 02:20:51 INFO - 2015-12-17 02:20:51,914 DEBUG : BROWSER_OUTPUT: Values: 279.7 02:20:51 INFO - 2015-12-17 02:20:51,915 DEBUG : BROWSER_OUTPUT: 02:20:51 INFO - 2015-12-17 02:20:51,915 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 02:20:51 INFO - 2015-12-17 02:20:51,915 DEBUG : BROWSER_OUTPUT: Values: 5191.7 02:20:51 INFO - 2015-12-17 02:20:51,915 DEBUG : BROWSER_OUTPUT: 02:20:51 INFO - 2015-12-17 02:20:51,915 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1968.50 Median:1968.50 stddev:0.00 (0.0%) 02:20:51 INFO - 2015-12-17 02:20:51,915 DEBUG : BROWSER_OUTPUT: Values: 1968.5 02:20:51 INFO - 2015-12-17 02:20:51,915 DEBUG : BROWSER_OUTPUT: 02:20:51 INFO - 2015-12-17 02:20:51,915 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.64 Median:788.64 stddev:0.00 (0.0%) 02:20:51 INFO - 2015-12-17 02:20:51,915 DEBUG : BROWSER_OUTPUT: Values: 788.6 02:20:51 INFO - 2015-12-17 02:20:51,916 DEBUG : BROWSER_OUTPUT: 02:20:51 INFO - 2015-12-17 02:20:51,916 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12708.86 Median:12708.86 stddev:0.00 (0.0%) 02:20:51 INFO - 2015-12-17 02:20:51,916 DEBUG : BROWSER_OUTPUT: Values: 12708.9 02:20:51 INFO - 2015-12-17 02:20:51,916 DEBUG : BROWSER_OUTPUT: 02:20:51 INFO - 2015-12-17 02:20:51,916 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25425.00 Median:25425.00 stddev:0.00 (0.0%) 02:20:51 INFO - 2015-12-17 02:20:51,916 DEBUG : BROWSER_OUTPUT: Values: 25425.0 02:20:51 INFO - 2015-12-17 02:20:51,916 DEBUG : BROWSER_OUTPUT: 02:20:51 INFO - 2015-12-17 02:20:51,916 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:677.05 Median:677.05 stddev:0.00 (0.0%) 02:20:51 INFO - 2015-12-17 02:20:51,916 DEBUG : BROWSER_OUTPUT: Values: 677.0 02:20:51 INFO - 2015-12-17 02:20:51,916 DEBUG : BROWSER_OUTPUT: 02:20:51 INFO - 2015-12-17 02:20:51,917 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 02:20:51 INFO - 2015-12-17 02:20:51,917 DEBUG : BROWSER_OUTPUT: Values: 4830.9 02:20:51 INFO - 2015-12-17 02:20:51,917 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:20:51 INFO - 2015-12-17 02:20:51,917 DEBUG : BROWSER_OUTPUT: 02:20:52 INFO - 2015-12-17 02:20:52,699 INFO : Browser exited with error code: 0 02:20:52 INFO - 2015-12-17 02:20:52,711 INFO : Completed test v8_7 (00:00:39) 02:20:52 INFO - 2015-12-17 02:20:52,896 INFO : Completed test suite (00:20:11) 02:20:52 INFO - 2015-12-17 02:20:52,896 DEBUG : Working with test: dromaeo_css 02:20:52 INFO - 2015-12-17 02:20:52,896 DEBUG : Generating results file: dromaeo_css 02:20:52 INFO - 2015-12-17 02:20:52,897 DEBUG : Working with test: kraken 02:20:52 INFO - 2015-12-17 02:20:52,897 DEBUG : Generating results file: kraken 02:20:52 INFO - 2015-12-17 02:20:52,897 INFO : javascript benchmark 02:20:52 INFO - 2015-12-17 02:20:52,898 DEBUG : Working with test: v8_7 02:20:52 INFO - 2015-12-17 02:20:52,898 DEBUG : Generating results file: v8_7 02:20:52 INFO - 2015-12-17 02:20:52,898 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:20:53 INFO - 2015-12-17 02:20:53,047 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 02:20:53 INFO - 2015-12-17 02:20:53,047 DEBUG : process_Request line: dromaeo_css 7050.52 graph.html#tests=[[72,64,35]] 02:20:53 INFO - 2015-12-17 02:20:53,047 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:20:53 INFO - 2015-12-17 02:20:53,181 DEBUG : process_Request line: kraken 1508.10 graph.html#tests=[[232,64,35]] 02:20:53 INFO - 2015-12-17 02:20:53,182 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:20:53 INFO - 2015-12-17 02:20:53,309 DEBUG : process_Request line: v8_7 19598.46 graph.html#tests=[[230,64,35]] 02:20:53 INFO - 2015-12-17 02:20:53,310 INFO : javascript benchmark 02:20:53 INFO - 2015-12-17 02:20:53,314 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3166.24010237543, 3183.952240716388, 3225.9838150982437, 3227.7579181561387, 3252.3495300939803, 5234.450382709808, 5307.336582927134, 5390.811321603745, 5434.538064264538, 5494.313210848649, 5371.5165635092935, 5406.378266499354, 5452.563794896409, 5524.33707955046, 5541.556675465963, 4948.5298896604945, 4984.3021976923255, 5020.0712868119335, 5067.569256613192, 5124.513171248744, 5028.120078986181, 5045.772940217681, 5091.618128640348, 5099.643024988252, 5110.259012443194, 4778.832740854071, 4832.275158726184, 4886.51134886512, 4898.461169271395, 4954.9752251238515, 4947.257911313296, 4952.727599981999, 4955.975220123876, 4975.651704380694, 4999.900001999939, 4871.391076115486, 4915.680480768774, 4928.26076088586, 4943.283223932545, 4995.100881841267, 5110.923336149961, 5195.090859099642, 5201.193814958688, 5208.348956380452, 5209.791608335662, 5672.886542269172, 5673.63121397112, 5679.403662615448, 5690.260266165414, 5691.373948865621, 5859.29688437386, 5872.765089396462, 5872.882542349172, 5880.26496687914, 5883.8529036774, 5392.460753924615, 5393.703346315911, 5430.67415955044, 5460.34475862895, 5523.392426833126, 5927.436893495111, 5953.493953013955, 6004.099385092271, 6006.399360063959, 6027.186329845415, 5808.5062769665055, 5830.329512106162, 5839.678817664984, 5889.4699477046415, 5890.970545147246, 5701.572382071361, 5720.1991721159075, 5805.564582656318, 5819.592628515963, 5920.733566989496, 5704.71476426177, 5712.34308054579, 5715.685637289906, 5715.914261286084, 5762.654240745569, 5723.284589426322, 5751.13732940054, 5751.511121554631, 5759.971200144057, 5775.306963164363, 4360.6729495287345, 4373.584509471595, 4396.230659634552, 4456.532064133284, 4484.372187893698, 3976.5824588418377, 4011.959880401217, 4013.13717550728, 4037.6366127048705, 4061.3704875744306, 5303.257543943851, 5314.415414304423, 5350.411454739976, 5385.434529374359, 5403.081476149064, 5598.048331783607, 5722.399148089474, 5723.227364305849, 5732.856678583069, 5806.65160090396, 5330.813421530228, 5423.0, 5423.403425623178, 5439.211314359396, 5480.314960629921, 5051.747412629354, 5066.949330506722, 5092.185250359925, 5095.87260318495, 5119.692818430906, 5856.619319744288, 5913.881722365614, 6041.972864613026, 6056.031035034373, 6073.939260607426, 5800.593958423039, 5822.359540450631, 5936.614120082181, 5941.079132734433, 5981.162637230878, 5949.286085669747, 5953.434423729739, 5958.76164953397, 5960.0, 5974.9402505974385, 5423.674579525241, 5520.006398848085, 5627.0715331971405, 5679.8864022720145, 5724.542036636975, 5639.520640745583, 5666.2350582670815, 5775.133729940542, 5816.82549523515, 5831.1836342912875, 5690.487856092972, 5790.710464476675, 5825.446582574648, 5825.79609713658, 5831.096180092092, 5608.158776183605, 5775.9133612995, 5793.768249269982, 5823.679697616672, 5824.330202026821, 5489.890202196014, 5536.806211782568, 5582.665040097607, 5637.351704554028, 5676.20533125371, 5689.971550142388, 5743.540516758733, 5747.827565173052, 5755.1367294906095, 5805.8548536286935, 5541.418151094077, 5638.323401191883, 5648.548116150616, 5654.773809047592, 5661.518770904519], "unit": "score", "name": "dojo.html", "value": 5352.227107881174}, {"lowerIsBetter": false, "replicates": [545.9543262600226, 584.8420926349886, 588.0620410445338, 588.5968111843387, 590.9852253693659, 30710.232244193878, 38744.806275968615, 38918.22163556731, 38943.805280973625, 38953.610463895355, 42622.36066458998, 43109.0, 43109.13781724364, 43169.78415107928, 43172.3524147138, 7697.961510192469, 7752.069751629812, 8796.736097917057, 8970.865437018418, 8980.146886045815, 10618.469076546142, 10846.67459976202, 10865.185111116698, 10868.61959831406, 10872.728181795439, 10519.63181288655, 10621.0, 10623.681289561326, 10623.734406639856, 10626.62806801762, 7972.641231144584, 8081.474704144271, 10526.473676316193, 10655.946720266427, 10912.945435272773, 10265.0, 10417.635382761642, 10424.791504169874, 10431.113355364803, 10434.37393756377, 39226.80386598077, 39447.802760986015, 39804.0, 39872.0, 39945.80027099875, 3284.080457471912, 3292.489664102044, 3335.0661814691684, 3337.1490269981, 3341.148007258158, 30501.542476862865, 30554.84722576373, 30669.8466507666, 31101.22246943822, 31253.687463125305, 3929.803509824526, 4074.0, 4084.12191378852, 4085.060436099684, 4116.670666346685, 275744.0, 278689.0, 278719.60640196875, 279018.0, 281649.0, 52616.736916315174, 53945.0, 59851.401485984585, 60259.0, 66085.33914660888, 58323.70838145782, 58438.0, 58857.41142588519, 58886.0, 58943.41056589465, 15010.0, 15268.541943741706, 15343.07941523512, 15359.385624574892, 15372.154531500652, 11388.601398950997, 11467.139964502696, 11523.884761152449, 11534.19260651763, 11547.364894930859, 19179.566717372112, 19393.8060619392, 19395.127219275168, 19468.61062778765, 19490.707639385422, 7843.490173138728, 7950.204979502004, 8117.269445749911, 8182.1817818217705, 8197.180281971756, 928.6053427293373, 1008.3143462445607, 1019.4087429290994, 1031.2523420520063, 1128.5147386623667, 28665.0, 28897.711022889922, 29014.41971160565, 29281.85359073191, 29453.90733972945, 970.815545046439, 1042.0881728487573, 1049.9475026248656, 1084.1326938449208, 1154.7979103656826, 14648.608382203674, 14933.551993440215, 15016.47442339513, 15148.621284467756, 15257.542273731806, 320717.0, 325027.0, 327150.0, 327464.0, 328619.0, 52215.73892130591, 52729.2090618641, 52765.0, 52819.20771188435, 52931.470685293425, 1326.2970625568464, 1337.0707358386023, 1340.5241139395569, 1341.2824139085737, 1353.7292541491545, 26771.0, 28194.43611127807, 28244.576331354634, 32365.352692945537, 32979.83510082434, 50041.24938125858, 50813.74593127011, 50858.49141508537, 50876.236856447926, 50916.49083509117, 277837.0, 285660.0, 414693.0, 421153.0, 428445.0, 40868.79565602153, 41867.7906610465, 41969.160616788104, 41985.79007104945, 42073.1585368297, 45872.0, 45926.0, 46266.76866615645, 46614.53385466102, 47197.29204061873, 37856.24287514179, 39363.60636393599, 39390.606093938695, 41995.7900210497, 42750.667698374564, 35680.10799729924, 36069.63930360663, 36222.8188859054, 36716.63283367239, 37095.62904370922, 35619.0, 36304.0, 36332.0, 36354.27291454209, 36626.26747465089, 31984.520232197003, 33147.17132071718, 33225.65529068021, 33330.16674583155, 33551.49672754862, 24911.87544062268, 25019.624705629067, 25028.24915252545, 25150.651282845327, 25310.367240819127], "unit": "score", "name": "ext.html", "value": 19324.352268164577}, {"lowerIsBetter": false, "replicates": [356.7609701499995, 361.887814777419, 362.28087246815073, 362.92378600493896, 364.74285628631816, 14161.575152745409, 14189.78715319271, 16978.49064528063, 17525.824741752596, 18237.179326930287, 14293.14241145532, 16554.83445165548, 16698.66602667946, 17619.82380176201, 17625.91187044066, 5367.704776237305, 5422.6475279106735, 5548.140038294051, 5552.611317207797, 5554.583406244547, 4011.2378648056774, 4129.359949207877, 5463.672179669233, 5502.779888804463, 5873.676947767871, 5925.2889653241455, 5947.988841896867, 5980.611260268069, 5994.0, 6002.699865006754, 5803.419658034184, 5880.7059647017695, 5884.293884733816, 5900.291964964189, 5902.380250073745, 5204.4535323791215, 5214.0, 5231.189165679326, 5232.0, 5232.084385232569, 20800.0, 20974.5805083899, 21093.894530527403, 21351.466213344636, 21397.893010535005, 2179.0412218623756, 2205.0848897707433, 2286.8627882327114, 2292.816574674022, 2373.2287006722713, 12865.485380584765, 13382.799258011137, 13417.865821341857, 13519.932400337935, 13632.182069075789, 1821.6083542038525, 1860.9813901860944, 1870.644577530265, 1891.6500447417272, 1900.8954507502083, 59258.40741592572, 61205.38794612041, 61916.99999999955, 62069.0, 62375.0, 9687.079727426024, 9806.852897206547, 9985.700428987142, 10004.149647280063, 10077.69766906994, 13151.736965260641, 13166.144200626928, 13210.933945330213, 13214.735705286033, 13221.140625859289, 7237.276272372721, 7265.673044713, 7272.272772722686, 7320.487565870444, 7323.853522929511, 6673.599584024877, 6706.698198581075, 6720.462363010947, 6886.48351373649, 6955.89566156508, 5924.851878703067, 5958.255218097738, 5983.850403739854, 5998.730057147439, 6012.549058820606, 1697.8047524534836, 1699.4731633193749, 1764.6823571757207, 1773.5122841218767, 1776.546980519959, 935.8455854784021, 965.6282331302359, 971.6696323250129, 1066.9519871605796, 1083.4366129612558, 17633.118344082744, 17726.822731772518, 17780.199891004937, 17859.46421607354, 17973.92156470616, 928.9163975242261, 963.2631037256505, 963.7012526116786, 973.2019743810149, 993.801239752038, 9832.655857044969, 10210.642627508001, 10245.84631230532, 10399.376037437778, 10482.528286227138, 527655.0, 534256.0, 541104.0, 541447.0, 553269.0, 82315.17684823195, 82794.0, 83580.0, 85298.57350713207, 86820.0, 1186.703324168975, 1191.065013964034, 1235.6046065259031, 1236.8268442418068, 1258.2261908925946, 15622.0, 15764.132972686612, 15793.0, 15878.444254451038, 15902.840971590598, 35014.47478287777, 35593.288134237686, 35957.685077789785, 36217.81891090633, 36228.456573151954, 47036.29445558251, 47421.0, 48226.517734822206, 50152.0, 50263.74868125782, 9648.807023859343, 9687.70936871895, 9768.462734549668, 9830.950845245728, 9872.259580531345, 17511.124443778015, 17878.106094695475, 17941.282348706427, 18034.098295084932, 18242.17910194018, 11632.709182270512, 11719.824202636797, 14130.293485325898, 14685.779713304522, 14993.0, 14299.928500357848, 14405.279736012948, 14531.854681453051, 14653.92673036628, 14918.955673103213, 11500.25248358854, 12014.33921134346, 13233.735325293634, 14149.575512734635, 15353.923230384224, 9293.581788819383, 9295.209907157967, 9350.43897366133, 9508.429494230368, 9528.428294302365, 10715.517801698787, 14033.719325613634, 14293.785593215902, 14340.784888226894, 14442.927785361006], "unit": "score", "name": "jquery.html", "value": 9129.867345145201}, {"lowerIsBetter": false, "replicates": [1505.1495904813787, 1698.9575260618483, 1732.9913350433253, 1768.1689605885229, 1772.7872655281376, 6474.708638111285, 7313.26867313269, 7467.1039475262905, 7476.028116344867, 7482.176960534337, 7306.305900939402, 7497.550146991171, 7501.474896757216, 7501.624918754054, 7502.287282708147, 1908.9522761930994, 1943.893085880276, 1944.7666280046415, 2194.5940001099766, 2228.142165266376, 2172.0334451169238, 2220.955580888381, 2221.711177546925, 2223.144089525528, 2225.1321984426086, 2109.5780843831217, 2159.3198142585034, 2194.594000109985, 2198.428408613764, 2198.8131008864184, 1833.9449816505526, 1860.5627677495777, 1866.8226518480858, 1867.7011678131503, 2166.9891650541726, 2180.8364372672113, 2210.5689390568846, 2211.734591848988, 2216.767239439868, 2222.3221917315213, 7328.083989501312, 7425.405967522639, 7428.071491063617, 7433.145188303361, 7439.3676537494375, 4467.664925130595, 4574.656900732459, 4575.450945886481, 4576.267797152473, 4583.793729282191, 2921.5334080917887, 2966.0805150403444, 2970.643522777259, 2973.7620990320725, 2994.505906525421, 956.1633570625703, 957.0859828863419, 959.8560215967591, 964.6623681711345, 1002.8094662014194, 10061.748456288578, 10119.291649584533, 10133.189344852393, 10137.746556336151, 10149.543270552844, 3969.3450580654444, 4010.979945100314, 4048.8785336439955, 4053.493313335833, 4072.063425412172, 8690.130986901386, 8694.652213911373, 8702.34732395073, 8704.825903481895, 8707.085755995657, 4477.104579084196, 4501.909961800746, 4504.572065653823, 4507.076049409863, 4507.5267096955, 4089.20260549196, 4129.648979836687, 4131.97934010328, 4132.214879172948, 4135.60711732385, 3544.3442963051916, 3549.6627820357025, 3570.232400034005, 3574.6782789548547, 3601.405768048243, 1162.4826952006276, 1165.7143999720122, 1175.7707247086737, 1176.805827038546, 1184.0586733546852, 1264.3741348032784, 1290.5289569307135, 1293.5601895355624, 1303.387407918277, 1319.1359659423092, 6760.492963027793, 7135.750248741269, 7256.238095000054, 7260.092488438945, 7307.1231452226075, 1100.8954149355798, 1112.3826276416505, 1117.201201141188, 1122.203235702644, 1133.2294040052843, 5063.13926632466, 5135.768890399941, 5635.520980716685, 5732.713364331767, 5793.159991801165, 8596.91403085961, 8635.093315201939, 8758.2993360531, 8878.245349145265, 8941.776455588662, 8866.512341821262, 8966.462012279153, 8975.0, 8980.371374003757, 8982.877140357456, 6898.758543451056, 7064.646767661597, 7084.504084714124, 7097.148342198866, 7097.325754053357, 6687.364700353459, 6828.5220034597105, 6857.382835544825, 6859.519833611599, 6880.759173428906, 7765.136367271927, 7955.209251210369, 7964.522128672298, 8037.7588672339925, 8050.27547520726, 7757.0, 8057.194280571896, 8102.027756669002, 8102.311303539265, 8239.670413183645, 7076.7523136692025, 7159.069320988238, 7167.462440317101, 7174.461915356264, 7174.533655312388, 6928.965355173192, 7024.964875175591, 7040.718371265092, 7048.330408611174, 7051.083359163276, 6453.870922581428, 6554.541182117397, 6633.800985970429, 6673.399394054559, 6770.492213084137, 6543.083968244355, 6550.377714117151, 6566.343365663586, 6640.867182656223, 6728.091707619605, 6596.967015164893, 6660.433863121689, 6662.966685166543, 6664.1003464533605, 6664.866702666017, 6095.939040609537, 6138.785142519991, 6152.077188421594, 6165.660888651168, 6271.0, 6257.593256438499, 6308.432241098323, 6323.557350985387, 6328.082428047999, 6333.081703153109], "unit": "score", "name": "mootools.html", "value": 4325.89038443716}, {"lowerIsBetter": false, "replicates": [335.1303367760661, 340.51646661740324, 344.86894979907623, 345.06315353814404, 345.6077352205246, 5740.0, 5865.325487568931, 5880.529557635389, 5881.735321910508, 5883.146943693162, 5673.149027645855, 5802.738876750545, 5814.331351894533, 5829.446202610756, 5834.620749651281, 4567.931481027771, 4583.0, 4593.908121837561, 4595.977020114895, 4603.40155779749, 4382.824687012516, 4447.822087116528, 4503.572160644733, 4591.265397536395, 4625.329327247547, 4506.684532082755, 4532.252178390561, 4545.681802273843, 4562.794674239651, 4565.429321334833, 4475.395821564096, 4481.170983368087, 4487.730736155841, 4503.48209955856, 4571.108633816407, 4033.2135233629456, 4038.353863381845, 4038.9192216155807, 4043.6158564936286, 4058.512978442606, 5495.917561236584, 5590.049691552445, 5631.63394379364, 5638.182463542763, 5651.8304450866535, 5155.587552995788, 5163.612729045337, 5215.556677682402, 5236.345456817898, 5246.003259380744, 5887.941120588782, 6233.0338797486465, 6239.844003899939, 6248.625082495065, 6250.0624906263965, 4232.365145228209, 4309.59058889405, 4355.716878402894, 4379.343098535245, 4388.736675799462, 6331.968340158316, 6371.235451745773, 6373.458256048241, 6408.0, 6438.25960014595, 4453.198424283595, 4455.1535208310315, 4456.68803183774, 4457.509673935864, 4477.664175186874, 4389.626881715026, 4489.438820147481, 4523.2988886722615, 4534.841280555164, 4538.931916021263, 5183.118869792144, 5223.085959956992, 5224.843254702365, 5225.137852254412, 5229.869253268623, 6249.9062514062325, 6253.1245625612455, 6253.8117757625905, 6254.8123556293385, 6270.843228919313, 1570.2855200883798, 1594.3702237616076, 1595.0, 1597.193417324267, 1598.4405458089575, 1068.8022715797601, 1070.3684825952569, 1075.2097208551709, 1077.0575746222055, 1092.5575142067476, 5934.1692163097205, 5941.584089113807, 5943.3849106393045, 5944.791932282349, 5944.7919322824355, 6359.427651511386, 6361.332060133712, 6363.649999249993, 6371.5221358397375, 6372.865090194744, 5930.199423077829, 5938.317093534299, 5940.524758019348, 5944.138099975479, 5952.285725712942, 3400.6769356911054, 3433.3476639438427, 3464.6535346465153, 3466.0295117367177, 3493.737969652286, 6612.537122401386, 6616.27221005689, 6617.43751781104, 6763.086983257295, 6771.0, 6683.365080317362, 6701.6314102723845, 6713.12729345182, 6713.462922966151, 6721.294264102296, 6572.539922205399, 6734.393904548614, 6739.258681545026, 6752.155980502437, 6765.05289259504, 6265.624062556261, 6448.290688024407, 6525.184351956005, 6532.477401807939, 6540.803775886731, 6329.588576742497, 6423.39852359795, 6457.063725759833, 6472.385123413268, 6473.2232132144445, 6722.2605513394465, 6727.360900714424, 6729.798106056826, 6735.966320168368, 6737.528373013842, 4377.737335759864, 4483.080968401405, 4531.977340113278, 4535.138323718483, 4538.6369090473345, 6382.170317858649, 6473.7376211638275, 6480.708368123352, 6481.805545833632, 6486.54594178403, 6250.468710159687, 6307.90538141919, 6315.4947604192475, 6317.241930968313, 6318.052292156213, 6194.132821405097, 6248.0, 6278.4035516625845, 6287.779927702509, 6293.685315734104, 6122.020476723703, 6147.385261473817, 6155.938440615716, 6166.136740856194, 6169.598976066542, 6280.780172693934, 6283.120363149072, 6293.685315734104, 6298.71655775482, 6298.937010629835, 6044.395560443921, 6145.938540614716, 6149.72326245329, 6152.630842149485, 6155.446009859134], "unit": "score", "name": "prototype.html", "value": 4729.699476349171}, {"lowerIsBetter": false, "replicates": [770.3721467004391, 803.2369249213245, 820.6389188756942, 825.5707032343182, 832.6461253967062, 13860.514881979132, 14061.648458788535, 14096.78854817176, 14103.57689269321, 14172.574822755309, 12478.625641230756, 12577.622671319852, 12587.118901676886, 12590.685232869182, 12592.118551701384, 682.5222344358943, 688.6419062087712, 814.4380377539509, 830.983380332393, 833.5998720614109, 827.1686954610637, 833.0378412933072, 836.7196989008689, 843.2916350265775, 843.3969711656165, 862.5557837713551, 874.2394117118116, 875.4703404440318, 875.8861348024748, 876.0494863073573, 715.0347031507475, 721.4805340155079, 854.8290341931638, 869.217704066339, 870.1907226279558, 632.1371328137105, 636.0554576453962, 636.745301879252, 637.1971316141695, 637.716216283754, 13379.799303010463, 13433.462661493528, 13490.730185396334, 13533.729325413437, 13616.659583510393, 11342.659720208407, 11988.760224795455, 12889.291088990101, 12920.289384083871, 13428.798568021488, 9957.153641940444, 10173.440460774655, 10323.122534584569, 10901.563937442494, 11149.777004459866, 3629.6007439181667, 3721.1255354991554, 3729.9813500932323, 3819.694424446038, 3831.2912111259507, 48975.51024489745, 49262.0, 49352.0, 49402.752986235195, 49422.0, 10003.949980250198, 10385.740356491147, 10609.0, 10640.78718425627, 10804.13566914645, 18976.620467590572, 18977.43067707971, 18982.430527083932, 18986.1456234467, 18988.62022759537, 7638.312551870247, 7732.342750866127, 7875.921240787518, 7994.389901823268, 8150.510969341858, 4038.45480860086, 4097.303458412077, 4119.629233369011, 4122.093139509303, 4130.834766609362, 3012.894548690785, 3026.9394612107635, 3037.0, 3038.453078445901, 3042.6348838139124, 535.5849216856967, 556.1018954388715, 556.471352215397, 560.6411896386317, 566.2553741829481, 555.8249151517259, 622.8104320747441, 651.501601275025, 675.3820254467107, 701.529974916807, 8621.612027458654, 8637.768129477148, 8815.338849586307, 8855.601497932608, 8859.0, 531.580051759106, 640.2317219336815, 653.7319698923419, 677.502036003537, 692.9501804765783, 3871.535415750128, 4050.18996200761, 4159.542450330461, 4331.285337919271, 4345.0, 60463.39536604666, 61736.69131654403, 61910.0713489298, 62202.0, 62569.37430625727, 53261.2010819838, 54318.45681543213, 54963.0, 55750.72124639351, 56087.0, 47411.28883066826, 47439.762801185774, 47698.0, 47807.760961194974, 49049.264261036114, 8618.827623447622, 8777.341699372444, 8885.866711999195, 9007.459552426875, 9159.725208243763, 35672.28655426825, 36125.81937090403, 36165.819170903975, 36524.086897827765, 36622.26755464823, 45974.54025459703, 47878.0, 48078.519214807406, 48107.27839082346, 48959.755201223765, 10432.217583681102, 10855.131589472665, 11023.118150547776, 11047.668569942914, 11106.777864442827, 11319.377434240867, 11641.825372619249, 11794.469248883992, 11876.346800926032, 11967.162298639012, 11025.117990560897, 11208.159388046091, 11306.738652269414, 11373.374464404536, 11778.52885884555, 11476.598319058792, 11696.473658685209, 11895.702607434883, 12067.336296503776, 12298.323592202514, 7948.0, 10439.686809395731, 11022.889771102507, 11060.502277397376, 11061.446927653746, 9119.273085554913, 9416.435013899189, 9420.0, 9586.808263834824, 9662.400443792743, 8706.695265665672, 8891.155340242667, 8923.598438070432, 9172.6789562365, 9226.9538652309], "unit": "score", "name": "yui.html", "value": 6357.256478857429}], "name": "dromaeo_css", "value": 7050.514490863479}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 111.0, 106.0, 109.0, 113.0, 110.0, 101.0, 111.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.2}, {"lowerIsBetter": true, "replicates": [149.0, 122.0, 154.0, 166.0, 126.0, 151.0, 147.0, 126.0, 162.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 142.7}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 162.0, 160.0, 162.0, 160.0, 162.0, 166.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 81.0, 94.0, 74.0, 79.0, 72.0, 119.0, 98.0, 74.0], "unit": "score", "name": "audio-fft", "value": 83.7}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 142.0, 93.0, 93.0, 93.0, 138.0, 92.0, 92.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 146.0, 147.0, 147.0, 148.0, 146.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 59.0, 58.0, 60.0, 57.0, 57.0, 66.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 68.0, 68.0, 68.0, 69.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 85.0, 86.0, 84.0, 95.0, 84.0, 93.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [124.0, 121.0, 122.0, 121.0, 126.0, 119.0, 123.0, 114.0, 118.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.7}, {"lowerIsBetter": true, "replicates": [142.0, 151.0, 154.0, 152.0, 153.0, 141.0, 163.0, 152.0, 143.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.4}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 70.0, 70.0, 68.0, 69.0, 67.0, 68.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1508.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.53550736633008], "unit": "score", "name": "Richards", "value": 213.25938200000004}, {"lowerIsBetter": false, "replicates": [188.78610534264678], "unit": "score", "name": "DeltaBlue", "value": 350.22704600000003}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1968.5039370078741], "unit": "score", "name": "RayTrace", "value": 375.9144119999999}, {"lowerIsBetter": false, "replicates": [788.6435331230284], "unit": "score", "name": "Earley", "value": 845.075084}, {"lowerIsBetter": false, "replicates": [12708.860759493671], "unit": "score", "name": "Boyer", "value": 52.440813745019945}, {"lowerIsBetter": false, "replicates": [25425.0], "unit": "score", "name": "RegExp", "value": 35.83028515240902}, {"lowerIsBetter": false, "replicates": [677.0480704129993], "unit": "score", "name": "Splay", "value": 120.36220700000004}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19598.455626958756}]} 02:20:53 INFO - RETURN: dromaeo_css: 7050.52 02:20:53 INFO - RETURN: kraken: 1508.10 02:20:53 INFO - RETURN: v8_7: 19598.46 02:20:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19598.46"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1508.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "7050.52"}}} 02:20:53 INFO - Return code: 0 02:20:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:20:53 INFO - # TBPL SUCCESS # 02:20:53 INFO - Running post-action listener: _resource_record_post_action 02:20:53 INFO - Running post-run listener: _resource_record_post_run 02:20:54 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 507355136; Read time: 0; Write time: 512812 02:20:54 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 238399488; Read time: 0; Write time: 321068 02:20:54 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 268955648; Read time: 0; Write time: 191744 02:20:54 INFO - Running post-run listener: _upload_blobber_files 02:20:54 INFO - Blob upload gear active. 02:20:54 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:20:54 INFO - Copying logs to upload dir... 02:20:54 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1273.504572 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-17 02:20:53.327855) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 02:20:53.331433) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009985 build_url: 'https://queue.taskcluster.net/v1/task/4HMDJFBvTYeeP2Gd2XypNA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 02:20:53.383197) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 02:20:53.383529) ========= 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=d7d9c069d1ebe471abe975fc000001d9-1450343407.646019-768757690 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 02:20:53.433830) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 02:20:53.434155) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 02:20:53.434435) ========= ========= Total master_lag: 0.23 =========