builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1448776893.42 results: success (0) buildid: 20151128203113 builduid: fa06906d24be491fbc1d065c174cf8de revision: cbf641f8da0af001a10b574b07a07035b50c30cf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:33.425167) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:33.425770) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:33.426046) ========= 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=919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009026 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:33.465603) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:33.465863) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:33.548687) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:33.548932) ========= 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=919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004663 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:33.602405) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:33.602725) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:33.603052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:33.603347) ========= 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=919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-28 22:01:34-- 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% 223M=0s 2015-11-28 22:01:35 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159970 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:33.775749) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:33.776022) ========= 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=919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019513 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:33.865361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:33.865660) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cbf641f8da0af001a10b574b07a07035b50c30cf --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 cbf641f8da0af001a10b574b07a07035b50c30cf --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=919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-28 22:01:35,288 truncating revision to first 12 chars 2015-11-28 22:01:35,288 Setting DEBUG logging. 2015-11-28 22:01:35,289 attempt 1/10 2015-11-28 22:01:35,289 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cbf641f8da0a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-28 22:01:35,539 unpacking tar archive at: fx-team-cbf641f8da0a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.556543 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:34.435038) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:34.435409) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:34.443442) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:34.443723) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-28 22:01:34.444127) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-28 22:01:34.444725) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:01:35 INFO - MultiFileLogger online at 20151128 22:01:35 in /builds/slave/test-pgo 22:01:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 22:01:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:01:35 INFO - {'append_to_log': False, 22:01:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:01:35 INFO - 'blob_upload_branch': 'Fx-Team', 22:01:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:01:35 INFO - 'branch': 'Fx-Team', 22:01:35 INFO - 'buildbot_json_path': 'buildprops.json', 22:01:35 INFO - 'config_files': ('talos/linux_config.py',), 22:01:35 INFO - 'default_actions': ('clobber', 22:01:35 INFO - 'read-buildbot-config', 22:01:35 INFO - 'download-and-extract', 22:01:35 INFO - 'populate-webroot', 22:01:35 INFO - 'create-virtualenv', 22:01:35 INFO - 'install', 22:01:35 INFO - 'run-tests'), 22:01:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:01:35 INFO - 'download_minidump_stackwalk': True, 22:01:35 INFO - 'download_symbols': 'ondemand', 22:01:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:01:35 INFO - 'tooltool.py': '/tools/tooltool.py', 22:01:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:01:35 INFO - '/tools/misc-python/virtualenv.py')}, 22:01:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:01:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:01:35 INFO - 'installer_path': 'installer.exe', 22:01:35 INFO - 'log_level': 'info', 22:01:35 INFO - 'log_name': 'talos', 22:01:35 INFO - 'log_to_console': True, 22:01:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:01:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:01:35 INFO - 'opt_config_files': (), 22:01:35 INFO - 'pip_index': False, 22:01:35 INFO - 'sps_profile': False, 22:01:35 INFO - 'sps_profile_interval': 0, 22:01:35 INFO - 'suite': 'dromaeojs-e10s', 22:01:35 INFO - 'system_bits': '64', 22:01:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:01:35 INFO - 'title': 'talos-linux64-ix-053', 22:01:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:01:35 INFO - 'use_talos_json': True, 22:01:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:01:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:01:35 INFO - 'work_dir': 'build'} 22:01:35 INFO - ##### 22:01:35 INFO - ##### Running clobber step. 22:01:35 INFO - ##### 22:01:35 INFO - Running pre-action listener: _resource_record_pre_action 22:01:35 INFO - Running main action method: clobber 22:01:35 INFO - rmtree: /builds/slave/test-pgo/build 22:01:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:01:36 INFO - Running post-action listener: _resource_record_post_action 22:01:36 INFO - ##### 22:01:36 INFO - ##### Running read-buildbot-config step. 22:01:36 INFO - ##### 22:01:36 INFO - Running pre-action listener: _resource_record_pre_action 22:01:36 INFO - Running main action method: read_buildbot_config 22:01:36 INFO - Using buildbot properties: 22:01:36 INFO - { 22:01:36 INFO - "properties": { 22:01:36 INFO - "buildnumber": 116, 22:01:36 INFO - "product": "firefox", 22:01:36 INFO - "script_repo_revision": "production", 22:01:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:01:36 INFO - "repository": "", 22:01:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:01:36 INFO - "buildid": "20151128203113", 22:01:36 INFO - "slavename": "talos-linux64-ix-053", 22:01:36 INFO - "pgo_build": "True", 22:01:36 INFO - "basedir": "/builds/slave/test-pgo", 22:01:36 INFO - "project": "", 22:01:36 INFO - "platform": "ubuntu64_hw", 22:01:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:01:36 INFO - "slavebuilddir": "test", 22:01:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:01:36 INFO - "branch": "fx-team", 22:01:36 INFO - "repo_path": "integration/fx-team", 22:01:36 INFO - "stage_platform": "linux64-pgo", 22:01:36 INFO - "builduid": "fa06906d24be491fbc1d065c174cf8de", 22:01:36 INFO - "revision": "cbf641f8da0af001a10b574b07a07035b50c30cf" 22:01:36 INFO - }, 22:01:36 INFO - "sourcestamp": { 22:01:36 INFO - "repository": "", 22:01:36 INFO - "hasPatch": false, 22:01:36 INFO - "project": "", 22:01:36 INFO - "branch": "fx-team-linux64-pgo-talos", 22:01:36 INFO - "changes": [ 22:01:36 INFO - { 22:01:36 INFO - "category": null, 22:01:36 INFO - "files": [ 22:01:36 INFO - { 22:01:36 INFO - "url": null, 22:01:36 INFO - "name": "https://queue.taskcluster.net/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:01:36 INFO - } 22:01:36 INFO - ], 22:01:36 INFO - "repository": "", 22:01:36 INFO - "rev": "cbf641f8da0af001a10b574b07a07035b50c30cf", 22:01:36 INFO - "who": "sendchange", 22:01:36 INFO - "when": 1448776843, 22:01:36 INFO - "number": 6718037, 22:01:36 INFO - "comments": "", 22:01:36 INFO - "project": "", 22:01:36 INFO - "at": "Sat 28 Nov 2015 22:00:43", 22:01:36 INFO - "branch": "fx-team-linux64-pgo-talos", 22:01:36 INFO - "revlink": "", 22:01:36 INFO - "properties": [ 22:01:36 INFO - [ 22:01:36 INFO - "buildid", 22:01:36 INFO - "20151128203113", 22:01:36 INFO - "Change" 22:01:36 INFO - ], 22:01:36 INFO - [ 22:01:36 INFO - "builduid", 22:01:36 INFO - "fa06906d24be491fbc1d065c174cf8de", 22:01:36 INFO - "Change" 22:01:36 INFO - ], 22:01:36 INFO - [ 22:01:36 INFO - "pgo_build", 22:01:36 INFO - "True", 22:01:36 INFO - "Change" 22:01:36 INFO - ] 22:01:36 INFO - ], 22:01:36 INFO - "revision": "cbf641f8da0af001a10b574b07a07035b50c30cf" 22:01:36 INFO - } 22:01:36 INFO - ], 22:01:36 INFO - "revision": "cbf641f8da0af001a10b574b07a07035b50c30cf" 22:01:36 INFO - } 22:01:36 INFO - } 22:01:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:01:36 INFO - Running post-action listener: _resource_record_post_action 22:01:36 INFO - ##### 22:01:36 INFO - ##### Running download-and-extract step. 22:01:36 INFO - ##### 22:01:36 INFO - Running pre-action listener: _resource_record_pre_action 22:01:36 INFO - Running main action method: download_and_extract 22:01:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:01:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:36 INFO - https://queue.taskcluster.net/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:01:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/test_packages.json 22:01:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/test_packages.json 22:01:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:01:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:01:42 INFO - Downloaded 1302 bytes. 22:01:42 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:01:42 INFO - Using the following test package requirements: 22:01:42 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:01:42 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:01:42 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:42 INFO - u'jsshell-linux-x86_64.zip'], 22:01:42 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:01:42 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:01:42 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:01:42 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:01:42 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:01:42 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:01:42 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:01:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:01:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:01: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')]} 22:01:42 INFO - https://queue.taskcluster.net/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:01:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:01:43 INFO - Downloaded 22763011 bytes. 22:01:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:01:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:01:44 INFO - Return code: 0 22:01:44 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:44 INFO - https://queue.taskcluster.net/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:01:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:01:46 INFO - Downloaded 22763011 bytes. 22:01:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 22:01:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:01:46 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:01:48 INFO - Return code: 0 22:01:48 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')]} 22:01:48 INFO - https://queue.taskcluster.net/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:01:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:01:49 INFO - Downloaded 11131728 bytes. 22:01:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 22:01:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:01:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 22:01:49 INFO - Return code: 0 22:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:49 INFO - https://queue.taskcluster.net/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:01:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:01:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:01:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:01:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:01:50 INFO - Downloaded 58408494 bytes. 22:01:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:01:50 INFO - mkdir: /builds/slave/test-pgo/properties 22:01:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:01:50 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:01:50 INFO - Contents: 22:01:50 INFO - build_url:https://queue.taskcluster.net/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:01:50 INFO - Running post-action listener: _resource_record_post_action 22:01:50 INFO - Running post-action listener: set_extra_try_arguments 22:01:50 INFO - ##### 22:01:50 INFO - ##### Running populate-webroot step. 22:01:50 INFO - ##### 22:01:50 INFO - Running pre-action listener: _resource_record_pre_action 22:01:50 INFO - Running main action method: populate_webroot 22:01:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:01:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:01:50 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:01:50 INFO - '../fennec_ids.txt'], 22:01:50 INFO - 'tests': ['tcheck2']}, 22:01:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:01:50 INFO - '--tppagecycles', 22:01:50 INFO - '7'], 22:01:50 INFO - 'tests': ['tsvgm']}}, 22:01:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:01:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:01:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:01:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:01:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:01:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:01:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:50 INFO - 'talos_options': ['--e10s'], 22:01:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:50 INFO - 'tests': ['damp', 'tps']}, 22:01:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:50 INFO - 'talos_options': ['--e10s'], 22:01:50 INFO - 'tests': ['damp', 'tps']}, 22:01:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:01:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:01:50 INFO - 'other': {'tests': ['a11yr', 22:01:50 INFO - 'ts_paint', 22:01:50 INFO - 'tpaint', 22:01:50 INFO - 'sessionrestore', 22:01:50 INFO - 'sessionrestore_no_auto_restore']}, 22:01:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:01:50 INFO - 'tests': ['a11yr', 22:01:50 INFO - 'ts_paint', 22:01:50 INFO - 'tpaint', 22:01:50 INFO - 'sessionrestore', 22:01:50 INFO - 'sessionrestore_no_auto_restore']}, 22:01:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:01:50 INFO - 'tests': ['a11yr', 22:01:50 INFO - 'ts_paint', 22:01:50 INFO - 'tpaint', 22:01:50 INFO - 'sessionrestore', 22:01:50 INFO - 'sessionrestore_no_auto_restore']}, 22:01:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:01:50 INFO - 'tests': ['a11yr', 22:01:50 INFO - 'ts_paint', 22:01:50 INFO - 'tpaint', 22:01:50 INFO - 'sessionrestore', 22:01:50 INFO - 'sessionrestore_no_auto_restore']}, 22:01:50 INFO - 'other_l64': {'tests': ['a11yr', 22:01:50 INFO - 'ts_paint', 22:01:50 INFO - 'tpaint', 22:01:50 INFO - 'sessionrestore', 22:01:50 INFO - 'sessionrestore_no_auto_restore']}, 22:01:50 INFO - 'other_nol64': {'tests': ['a11yr', 22:01:50 INFO - 'ts_paint', 22:01:50 INFO - 'tpaint', 22:01:50 INFO - 'sessionrestore', 22:01:50 INFO - 'sessionrestore_no_auto_restore']}, 22:01:50 INFO - 'svgr': {'tests': ['tsvgx', 22:01:50 INFO - 'tsvgr_opacity', 22:01:50 INFO - 'tart', 22:01:50 INFO - 'tscrollx', 22:01:50 INFO - 'cart']}, 22:01:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:01:50 INFO - 'tests': ['tsvgx', 22:01:50 INFO - 'tsvgr_opacity', 22:01:50 INFO - 'tart', 22:01:50 INFO - 'tscrollx', 22:01:50 INFO - 'cart']}, 22:01:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:50 INFO - 'tests': ['tp5o']}, 22:01:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:50 INFO - 'talos_options': ['--e10s'], 22:01:50 INFO - 'tests': ['tp5o']}, 22:01:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:50 INFO - 'talos_options': ['--xperf_path', 22:01:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:50 INFO - 'tests': ['tp5n']}, 22:01:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:01:50 INFO - 'talos_options': ['--e10s', 22:01:50 INFO - '--xperf_path', 22:01:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:50 INFO - 'tests': ['tp5n']}}, 22:01:50 INFO - 'talos.zip': {'path': '', 22:01:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:01:50 INFO - Running post-action listener: _resource_record_post_action 22:01:50 INFO - ##### 22:01:50 INFO - ##### Running create-virtualenv step. 22:01:50 INFO - ##### 22:01:50 INFO - Running pre-action listener: _resource_record_pre_action 22:01:50 INFO - Running main action method: create_virtualenv 22:01:50 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:01:50 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 22:01:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:01:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:01:51 INFO - Using real prefix '/usr' 22:01:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:01:51 INFO - Installing distribute.............................................................................................................................................................................................done. 22:01:53 INFO - Installing pip.................done. 22:01:53 INFO - Return code: 0 22:01:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fccbac2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080350>, '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 0x2081250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20816e0>, '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': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', '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 22:01:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:01:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:01:53 INFO - Using env: {'DISPLAY': ':0', 22:01:53 INFO - 'HOME': '/home/cltbld', 22:01:53 INFO - 'LANG': 'en_US.UTF-8', 22:01:53 INFO - 'LANGUAGE': 'en_US:en', 22:01:53 INFO - 'LOGNAME': 'cltbld', 22:01:53 INFO - 'MAIL': '/var/mail/cltbld', 22:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:53 INFO - 'MOZ_NO_REMOTE': '1', 22:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:53 INFO - 'NO_EM_RESTART': '1', 22:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:53 INFO - 'SHELL': '/bin/bash', 22:01:53 INFO - 'SHLVL': '1', 22:01:53 INFO - 'TERM': 'linux', 22:01:53 INFO - 'TMOUT': '86400', 22:01:53 INFO - 'USER': 'cltbld', 22:01:53 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', 22:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:53 INFO - '_': '/tools/buildbot/bin/python'} 22:01:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:53 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 22:01:53 INFO - Cleaning up... 22:01:53 INFO - Return code: 0 22:01:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:53 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fccbac2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080350>, '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 0x2081250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20816e0>, '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': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', '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 22:01:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:01:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:01:53 INFO - Using env: {'DISPLAY': ':0', 22:01:53 INFO - 'HOME': '/home/cltbld', 22:01:53 INFO - 'LANG': 'en_US.UTF-8', 22:01:53 INFO - 'LANGUAGE': 'en_US:en', 22:01:53 INFO - 'LOGNAME': 'cltbld', 22:01:53 INFO - 'MAIL': '/var/mail/cltbld', 22:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:53 INFO - 'MOZ_NO_REMOTE': '1', 22:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:53 INFO - 'NO_EM_RESTART': '1', 22:01:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:53 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:53 INFO - 'SHELL': '/bin/bash', 22:01:53 INFO - 'SHLVL': '1', 22:01:53 INFO - 'TERM': 'linux', 22:01:53 INFO - 'TMOUT': '86400', 22:01:53 INFO - 'USER': 'cltbld', 22:01:53 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', 22:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:53 INFO - '_': '/tools/buildbot/bin/python'} 22:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:54 INFO - Downloading/unpacking psutil>=0.7.1 22:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:55 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:01:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:01:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:01:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:55 INFO - Installing collected packages: psutil 22:01:55 INFO - Running setup.py install for psutil 22:01:55 INFO - building 'psutil._psutil_linux' extension 22:01:55 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 22:01:56 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 22:01:56 INFO - building 'psutil._psutil_posix' extension 22:01:56 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 22:01:56 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 22:01:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:56 INFO - Successfully installed psutil 22:01:56 INFO - Cleaning up... 22:01:56 INFO - Return code: 0 22:01:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:01:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fccbac2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080350>, '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 0x2081250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20816e0>, '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': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', '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 22:01:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:01:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:01:56 INFO - Using env: {'DISPLAY': ':0', 22:01:56 INFO - 'HOME': '/home/cltbld', 22:01:56 INFO - 'LANG': 'en_US.UTF-8', 22:01:56 INFO - 'LANGUAGE': 'en_US:en', 22:01:56 INFO - 'LOGNAME': 'cltbld', 22:01:56 INFO - 'MAIL': '/var/mail/cltbld', 22:01:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:56 INFO - 'MOZ_NO_REMOTE': '1', 22:01:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:56 INFO - 'NO_EM_RESTART': '1', 22:01:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:56 INFO - 'SHELL': '/bin/bash', 22:01:56 INFO - 'SHLVL': '1', 22:01:56 INFO - 'TERM': 'linux', 22:01:56 INFO - 'TMOUT': '86400', 22:01:56 INFO - 'USER': 'cltbld', 22:01:56 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', 22:01:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:56 INFO - '_': '/tools/buildbot/bin/python'} 22:01:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:01:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:01:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:01:58 INFO - Installing collected packages: mozsystemmonitor 22:01:58 INFO - Running setup.py install for mozsystemmonitor 22:01:58 INFO - Successfully installed mozsystemmonitor 22:01:58 INFO - Cleaning up... 22:01:58 INFO - Return code: 0 22:01:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:01: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')]} 22:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01: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')]} 22:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:58 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 0x7fccbac2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080350>, '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 0x2081250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20816e0>, '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': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', '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 22:01:58 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 22:01:58 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 22:01:58 INFO - Using env: {'DISPLAY': ':0', 22:01:58 INFO - 'HOME': '/home/cltbld', 22:01:58 INFO - 'LANG': 'en_US.UTF-8', 22:01:58 INFO - 'LANGUAGE': 'en_US:en', 22:01:58 INFO - 'LOGNAME': 'cltbld', 22:01:58 INFO - 'MAIL': '/var/mail/cltbld', 22:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:58 INFO - 'MOZ_NO_REMOTE': '1', 22:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:58 INFO - 'NO_EM_RESTART': '1', 22:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:01:58 INFO - 'PWD': '/builds/slave/test-pgo', 22:01:58 INFO - 'SHELL': '/bin/bash', 22:01:58 INFO - 'SHLVL': '1', 22:01:58 INFO - 'TERM': 'linux', 22:01:58 INFO - 'TMOUT': '86400', 22:01:58 INFO - 'USER': 'cltbld', 22:01:58 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', 22:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:58 INFO - '_': '/tools/buildbot/bin/python'} 22:01:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:58 INFO - Downloading/unpacking blobuploader==1.2.4 22:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:00 INFO - Downloading blobuploader-1.2.4.tar.gz 22:02:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:02:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:02:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:02:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:02:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:02:00 INFO - Downloading docopt-0.6.1.tar.gz 22:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:02:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:02:01 INFO - Installing collected packages: blobuploader, requests, docopt 22:02:01 INFO - Running setup.py install for blobuploader 22:02:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:02:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:02:01 INFO - Running setup.py install for requests 22:02:01 INFO - Running setup.py install for docopt 22:02:01 INFO - Successfully installed blobuploader requests docopt 22:02:01 INFO - Cleaning up... 22:02:01 INFO - Return code: 0 22:02:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:02:01 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')]} 22:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:01 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')]} 22:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:01 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 0x7fccbac2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080350>, '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 0x2081250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20816e0>, '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': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', '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 22:02:01 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 22:02:01 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 22:02:01 INFO - Using env: {'DISPLAY': ':0', 22:02:01 INFO - 'HOME': '/home/cltbld', 22:02:01 INFO - 'LANG': 'en_US.UTF-8', 22:02:01 INFO - 'LANGUAGE': 'en_US:en', 22:02:01 INFO - 'LOGNAME': 'cltbld', 22:02:01 INFO - 'MAIL': '/var/mail/cltbld', 22:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:01 INFO - 'MOZ_NO_REMOTE': '1', 22:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:01 INFO - 'NO_EM_RESTART': '1', 22:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:02:01 INFO - 'PWD': '/builds/slave/test-pgo', 22:02:01 INFO - 'SHELL': '/bin/bash', 22:02:01 INFO - 'SHLVL': '1', 22:02:01 INFO - 'TERM': 'linux', 22:02:01 INFO - 'TMOUT': '86400', 22:02:01 INFO - 'USER': 'cltbld', 22:02:01 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', 22:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:01 INFO - '_': '/tools/buildbot/bin/python'} 22:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:02:01 INFO - Running setup.py (path:/tmp/pip-6fPYGh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:02:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:02:01 INFO - Running setup.py (path:/tmp/pip-yDunOS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:02:02 INFO - Running setup.py (path:/tmp/pip-OPbOC2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:02:02 INFO - Running setup.py (path:/tmp/pip-P8wPmV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:02:02 INFO - Running setup.py (path:/tmp/pip-t9gG7S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:02:02 INFO - Running setup.py (path:/tmp/pip-8QhAO1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:02:02 INFO - Running setup.py (path:/tmp/pip-Kw5H6P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:02:02 INFO - Running setup.py (path:/tmp/pip-14OP1G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:02:02 INFO - Running setup.py (path:/tmp/pip-aXNRWR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:02:02 INFO - Running setup.py (path:/tmp/pip-JOVHt0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:02:02 INFO - Running setup.py (path:/tmp/pip-6jLU4W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:02:02 INFO - Running setup.py (path:/tmp/pip-mw0PSZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:02:02 INFO - Running setup.py (path:/tmp/pip-oZcmqN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:02:02 INFO - Running setup.py (path:/tmp/pip-bfGFNX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:02:02 INFO - Running setup.py (path:/tmp/pip-S_gLhs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:02:02 INFO - Running setup.py (path:/tmp/pip-iT2d6c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:02:03 INFO - Running setup.py (path:/tmp/pip-RES9IC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:02:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:02:03 INFO - Running setup.py install for manifestparser 22:02:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:02:03 INFO - Running setup.py install for mozcrash 22:02:03 INFO - Running setup.py install for mozdebug 22:02:03 INFO - Running setup.py install for mozdevice 22:02:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:02:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:02:03 INFO - Running setup.py install for mozfile 22:02:03 INFO - Running setup.py install for mozhttpd 22:02:03 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:02:03 INFO - Running setup.py install for mozinfo 22:02:03 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:02:03 INFO - Running setup.py install for mozInstall 22:02:03 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:02:03 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:02:03 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:02:03 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:02:03 INFO - Running setup.py install for mozleak 22:02:04 INFO - Running setup.py install for mozlog 22:02:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:02:04 INFO - Running setup.py install for moznetwork 22:02:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:02:04 INFO - Running setup.py install for mozprocess 22:02:04 INFO - Running setup.py install for mozprofile 22:02:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:02:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:02:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:02:04 INFO - Running setup.py install for mozrunner 22:02:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:02:04 INFO - Running setup.py install for mozscreenshot 22:02:04 INFO - Running setup.py install for moztest 22:02:04 INFO - Running setup.py install for mozversion 22:02:04 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:02:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:02:04 INFO - Cleaning up... 22:02:04 INFO - Return code: 0 22:02:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:02:04 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')]} 22:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:04 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')]} 22:02:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:04 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 0x7fccbac2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080350>, '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 0x2081250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20816e0>, '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': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', '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 22:02:04 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 22:02:04 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 22:02:04 INFO - Using env: {'DISPLAY': ':0', 22:02:04 INFO - 'HOME': '/home/cltbld', 22:02:04 INFO - 'LANG': 'en_US.UTF-8', 22:02:04 INFO - 'LANGUAGE': 'en_US:en', 22:02:04 INFO - 'LOGNAME': 'cltbld', 22:02:04 INFO - 'MAIL': '/var/mail/cltbld', 22:02:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:04 INFO - 'MOZ_NO_REMOTE': '1', 22:02:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:04 INFO - 'NO_EM_RESTART': '1', 22:02:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:02:04 INFO - 'PWD': '/builds/slave/test-pgo', 22:02:04 INFO - 'SHELL': '/bin/bash', 22:02:04 INFO - 'SHLVL': '1', 22:02:04 INFO - 'TERM': 'linux', 22:02:04 INFO - 'TMOUT': '86400', 22:02:04 INFO - 'USER': 'cltbld', 22:02:04 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', 22:02:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:04 INFO - '_': '/tools/buildbot/bin/python'} 22:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:02:05 INFO - Running setup.py (path:/tmp/pip-KjjF0s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:02:05 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)) 22:02:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:02:05 INFO - Running setup.py (path:/tmp/pip-qUilzK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:02:05 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)) 22:02:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:02:05 INFO - Running setup.py (path:/tmp/pip-jIbigO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:02:05 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)) 22:02:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:02:05 INFO - Running setup.py (path:/tmp/pip-HYchMn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:02:05 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)) 22:02:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:02:05 INFO - Running setup.py (path:/tmp/pip-ukGDqv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:02:05 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)) 22:02:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:02:05 INFO - Running setup.py (path:/tmp/pip-5t57cD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:02:05 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)) 22:02:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:02:05 INFO - Running setup.py (path:/tmp/pip-4j8nkP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:02:05 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)) 22:02:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:02:05 INFO - Running setup.py (path:/tmp/pip-SruVoy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:02:05 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)) 22:02:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:02:05 INFO - Running setup.py (path:/tmp/pip-dobCsK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:02:05 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)) 22:02:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:02:05 INFO - Running setup.py (path:/tmp/pip-ukXBPN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:02:05 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)) 22:02:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:02:05 INFO - Running setup.py (path:/tmp/pip-k3MXbX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:02:05 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)) 22:02:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:02:05 INFO - Running setup.py (path:/tmp/pip-aQmijW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:02:05 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)) 22:02:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:02:06 INFO - Running setup.py (path:/tmp/pip-MW10YT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:02:06 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)) 22:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:02:06 INFO - Running setup.py (path:/tmp/pip-XEYxQQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:02:06 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)) 22:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:02:06 INFO - Running setup.py (path:/tmp/pip-9jMubP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:02:06 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)) 22:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:02:06 INFO - Running setup.py (path:/tmp/pip-OooZci-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:02:06 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)) 22:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:02:06 INFO - Running setup.py (path:/tmp/pip-AWIMsK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:02:06 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)) 22:02:06 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)) 22:02:06 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)) 22:02:06 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)) 22:02:06 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)) 22:02:06 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)) 22:02:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:02:06 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 22:02:06 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 22:02:06 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 22:02:06 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 22:02:06 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 22:02:06 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 22:02:08 INFO - Downloading blessings-1.5.1.tar.gz 22:02:08 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 22:02:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:02:08 INFO - Installing collected packages: blessings 22:02:08 INFO - Running setup.py install for blessings 22:02:08 INFO - Successfully installed blessings 22:02:08 INFO - Cleaning up... 22:02:08 INFO - Return code: 0 22:02:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:02:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:02:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:02:08 INFO - Reading from file tmpfile_stdout 22:02:08 INFO - Current package versions: 22:02:08 INFO - argparse == 1.2.1 22:02:08 INFO - blessings == 1.5.1 22:02:08 INFO - blobuploader == 1.2.4 22:02:08 INFO - docopt == 0.6.1 22:02:08 INFO - manifestparser == 1.1 22:02:08 INFO - mozInstall == 1.12 22:02:08 INFO - mozcrash == 0.16 22:02:08 INFO - mozdebug == 0.1 22:02:08 INFO - mozdevice == 0.47 22:02:08 INFO - mozfile == 1.2 22:02:08 INFO - mozhttpd == 0.7 22:02:08 INFO - mozinfo == 0.9 22:02:08 INFO - mozleak == 0.1 22:02:08 INFO - mozlog == 3.1 22:02:08 INFO - moznetwork == 0.27 22:02:08 INFO - mozprocess == 0.22 22:02:08 INFO - mozprofile == 0.27 22:02:08 INFO - mozrunner == 6.11 22:02:08 INFO - mozscreenshot == 0.1 22:02:08 INFO - mozsystemmonitor == 0.0 22:02:08 INFO - moztest == 0.7 22:02:08 INFO - mozversion == 1.4 22:02:08 INFO - psutil == 3.1.1 22:02:08 INFO - requests == 1.2.3 22:02:08 INFO - wsgiref == 0.1.2 22:02:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:02:08 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')]} 22:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:08 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')]} 22:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:08 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 0x7fccbac2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080350>, '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 0x2081250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20816e0>, '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': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', '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 22:02:08 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 22:02:08 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 22:02:08 INFO - Using env: {'DISPLAY': ':0', 22:02:08 INFO - 'HOME': '/home/cltbld', 22:02:08 INFO - 'LANG': 'en_US.UTF-8', 22:02:08 INFO - 'LANGUAGE': 'en_US:en', 22:02:08 INFO - 'LOGNAME': 'cltbld', 22:02:08 INFO - 'MAIL': '/var/mail/cltbld', 22:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:08 INFO - 'MOZ_NO_REMOTE': '1', 22:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:08 INFO - 'NO_EM_RESTART': '1', 22:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:02:08 INFO - 'PWD': '/builds/slave/test-pgo', 22:02:08 INFO - 'SHELL': '/bin/bash', 22:02:08 INFO - 'SHLVL': '1', 22:02:08 INFO - 'TERM': 'linux', 22:02:08 INFO - 'TMOUT': '86400', 22:02:08 INFO - 'USER': 'cltbld', 22:02:08 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', 22:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:08 INFO - '_': '/tools/buildbot/bin/python'} 22:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:08 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)) 22:02:08 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)) 22:02:08 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)) 22:02:08 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)) 22:02:08 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)) 22:02:08 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)) 22:02:08 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)) 22:02:08 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)) 22:02:08 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)) 22:02:08 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)) 22:02:08 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)) 22:02:08 INFO - Cleaning up... 22:02:08 INFO - Return code: 0 22:02:08 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:02:08 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')]} 22:02:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:08 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')]} 22:02:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:08 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 0x7fccbac2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080350>, '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 0x2081250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20816e0>, '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': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', '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 22:02:08 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 22:02:08 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 22:02:08 INFO - Using env: {'DISPLAY': ':0', 22:02:08 INFO - 'HOME': '/home/cltbld', 22:02:08 INFO - 'LANG': 'en_US.UTF-8', 22:02:08 INFO - 'LANGUAGE': 'en_US:en', 22:02:08 INFO - 'LOGNAME': 'cltbld', 22:02:08 INFO - 'MAIL': '/var/mail/cltbld', 22:02:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:08 INFO - 'MOZ_NO_REMOTE': '1', 22:02:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:08 INFO - 'NO_EM_RESTART': '1', 22:02:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:02:08 INFO - 'PWD': '/builds/slave/test-pgo', 22:02:08 INFO - 'SHELL': '/bin/bash', 22:02:08 INFO - 'SHLVL': '1', 22:02:08 INFO - 'TERM': 'linux', 22:02:08 INFO - 'TMOUT': '86400', 22:02:08 INFO - 'USER': 'cltbld', 22:02:08 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', 22:02:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:08 INFO - '_': '/tools/buildbot/bin/python'} 22:02:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:08 INFO - Downloading/unpacking jsonschema 22:02:08 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 22:02:08 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 22:02:08 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 22:02:08 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 22:02:08 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 22:02:08 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 22:02:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:02:10 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 22:02:10 INFO - Downloading/unpacking functools32 (from jsonschema) 22:02:10 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 22:02:10 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 22:02:10 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 22:02:10 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 22:02:10 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 22:02:10 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 22:02:10 INFO - Downloading functools32-3.2.3-2.tar.gz 22:02:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:02:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:02:10 INFO - warning: no files found matching '*.txt' 22:02:10 INFO - no previously-included directories found matching 'build' 22:02:10 INFO - no previously-included directories found matching 'dist' 22:02:10 INFO - no previously-included directories found matching '.git*' 22:02:10 INFO - Installing collected packages: jsonschema, functools32 22:02:10 INFO - Running setup.py install for functools32 22:02:10 INFO - warning: no files found matching '*.txt' 22:02:10 INFO - no previously-included directories found matching 'build' 22:02:10 INFO - no previously-included directories found matching 'dist' 22:02:10 INFO - no previously-included directories found matching '.git*' 22:02:11 INFO - Successfully installed jsonschema functools32 22:02:11 INFO - Cleaning up... 22:02:11 INFO - Return code: 0 22:02:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:02:11 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')]} 22:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:11 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')]} 22:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:02:11 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 0x7fccbac2df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f248a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ff1600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2080350>, '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 0x2081250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20816e0>, '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': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', '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 22:02:11 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 22:02:11 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 22:02:11 INFO - Using env: {'DISPLAY': ':0', 22:02:11 INFO - 'HOME': '/home/cltbld', 22:02:11 INFO - 'LANG': 'en_US.UTF-8', 22:02:11 INFO - 'LANGUAGE': 'en_US:en', 22:02:11 INFO - 'LOGNAME': 'cltbld', 22:02:11 INFO - 'MAIL': '/var/mail/cltbld', 22:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:11 INFO - 'MOZ_NO_REMOTE': '1', 22:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:11 INFO - 'NO_EM_RESTART': '1', 22:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:02:11 INFO - 'PWD': '/builds/slave/test-pgo', 22:02:11 INFO - 'SHELL': '/bin/bash', 22:02:11 INFO - 'SHLVL': '1', 22:02:11 INFO - 'TERM': 'linux', 22:02:11 INFO - 'TMOUT': '86400', 22:02:11 INFO - 'USER': 'cltbld', 22:02:11 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', 22:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:11 INFO - '_': '/tools/buildbot/bin/python'} 22:02:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:02:11 INFO - Downloading/unpacking flake8 22:02: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 22:02: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 22:02: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 22:02: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 22:02: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 22:02: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 22:02:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:02:12 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 22:02:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:02:12 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 22:02:12 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 22:02:12 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 22:02:12 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 22:02:12 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 22:02:12 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 22:02:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:02:13 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 22:02:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:02:13 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 22:02:13 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 22:02:13 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 22:02:13 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 22:02:13 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 22:02:13 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 22:02:13 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 22:02:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:02:13 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 22:02:13 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 22:02:13 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 22:02:13 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 22:02:13 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 22:02:13 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 22:02:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:02:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:02:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:02:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:02:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:02:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:02:13 INFO - no previously-included directories found matching 'docs/_build' 22:02:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:02:13 INFO - Running setup.py install for pep8 22:02:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:02:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:02:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:02:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:02:13 INFO - no previously-included directories found matching 'docs/_build' 22:02:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:02:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:02:13 INFO - Cleaning up... 22:02:13 INFO - Return code: 0 22:02:13 INFO - Running post-action listener: _resource_record_post_action 22:02:13 INFO - Running post-action listener: _start_resource_monitoring 22:02:13 INFO - Starting resource monitoring. 22:02:13 INFO - ##### 22:02:13 INFO - ##### Running install step. 22:02:13 INFO - ##### 22:02:13 INFO - Running pre-action listener: _resource_record_pre_action 22:02:13 INFO - Running main action method: install 22:02:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:02:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:02:14 INFO - Reading from file tmpfile_stdout 22:02:14 INFO - Detecting whether we're running mozinstall >=1.0... 22:02:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:02:14 INFO - Reading from file tmpfile_stdout 22:02:14 INFO - Output received: 22:02:14 INFO - Usage: mozinstall [options] installer 22:02:14 INFO - Options: 22:02:14 INFO - -h, --help show this help message and exit 22:02:14 INFO - -d DEST, --destination=DEST 22:02:14 INFO - Directory to install application into. [default: 22:02:14 INFO - "/builds/slave/test-pgo"] 22:02:14 INFO - --app=APP Application being installed. [default: firefox] 22:02:14 INFO - mkdir: /builds/slave/test-pgo/build/application 22:02:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:02:28 INFO - Reading from file tmpfile_stdout 22:02:28 INFO - Output received: 22:02:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:02:28 INFO - Running post-action listener: _resource_record_post_action 22:02:28 INFO - ##### 22:02:28 INFO - ##### Running run-tests step. 22:02:28 INFO - ##### 22:02:28 INFO - Running pre-action listener: _resource_record_pre_action 22:02:28 INFO - Running main action method: run_tests 22:02:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:02:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:02:28 INFO - Python 2.7.3 22:02:28 INFO - Return code: 0 22:02:28 INFO - grabbing minidump binary from tooltool 22:02:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:02:28 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 0x2080350>, '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 0x2081250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20816e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:02:28 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 22:02:28 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 22:02:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:02:28 INFO - Return code: 0 22:02:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:02:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:02:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:02:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:02:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:02:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:02:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:02:29 INFO - Return code: 0 22:02:29 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 22:02:29 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost 22:02:29 INFO - Using env: {'DISPLAY': ':0', 22:02:29 INFO - 'HOME': '/home/cltbld', 22:02:29 INFO - 'LANG': 'en_US.UTF-8', 22:02:29 INFO - 'LANGUAGE': 'en_US:en', 22:02:29 INFO - 'LOGNAME': 'cltbld', 22:02:29 INFO - 'MAIL': '/var/mail/cltbld', 22:02:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:02:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:02:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:02:29 INFO - 'MOZ_NO_REMOTE': '1', 22:02:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:02:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:02:29 INFO - 'NO_EM_RESTART': '1', 22:02:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:02:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:02:29 INFO - 'PWD': '/builds/slave/test-pgo', 22:02:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:02:29 INFO - 'SHELL': '/bin/bash', 22:02:29 INFO - 'SHLVL': '1', 22:02:29 INFO - 'TERM': 'linux', 22:02:29 INFO - 'TMOUT': '86400', 22:02:29 INFO - 'USER': 'cltbld', 22:02:29 INFO - 'XDG_SESSION_COOKIE': '919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638', 22:02:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:02:29 INFO - '_': '/tools/buildbot/bin/python'} 22:02:29 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost'] with output_timeout 3600 22:02:29 INFO - mozversion INFO | application_buildid: 20151128203113 22:02:29 INFO - mozversion INFO | application_changeset: cbf641f8da0af001a10b574b07a07035b50c30cf 22:02:29 INFO - mozversion INFO | application_display_name: Nightly 22:02:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:02:29 INFO - mozversion INFO | application_name: Firefox 22:02:29 INFO - mozversion INFO | application_remotingname: firefox 22:02:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:02:29 INFO - mozversion INFO | application_vendor: Mozilla 22:02:29 INFO - mozversion INFO | application_version: 45.0a1 22:02:29 INFO - mozversion INFO | platform_buildid: 20151128203113 22:02:29 INFO - mozversion INFO | platform_changeset: cbf641f8da0af001a10b574b07a07035b50c30cf 22:02:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:02:29 INFO - mozversion INFO | platform_version: 45.0a1 22:02:29 INFO - 2015-11-28 22:02:29,960 DEBUG : using testdate: 1448776949 22:02:29 INFO - 2015-11-28 22:02:29,960 DEBUG : actual date: 1448776949 22:02:30 INFO - 2015-11-28 22:02:30,007 INFO : starting webserver on 'localhost:49593' 22:02:30 INFO - 2015-11-28 22:02:30,008 INFO : Starting test suite talos-linux64-ix-053.e 22:02:30 INFO - 2015-11-28 22:02:30,008 INFO : Starting test dromaeo_css 22:02:30 INFO - 2015-11-28 22:02:30,008 DEBUG : operating with platform_type : linux_ 22:02:30 INFO - 2015-11-28 22:02:30,009 INFO : Initialising browser for dromaeo_css test... 22:02:30 INFO - 2015-11-28 22:02:30,025 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnkI45V/profile http://localhost:49593/getInfo.html 22:02:33 INFO - 2015-11-28 22:02:33,964 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:02:33 INFO - 2015-11-28 22:02:33,964 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:02:33 INFO - 2015-11-28 22:02:33,964 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:02:33 INFO - 2015-11-28 22:02:33,964 DEBUG : BROWSER_OUTPUT: __metrics 22:02:34 INFO - 2015-11-28 22:02:34,849 INFO : Browser initialized. 22:02:34 INFO - 2015-11-28 22:02:34,850 INFO : Running cycle 1/1 for dromaeo_css test... 22:02:34 INFO - 2015-11-28 22:02:34,850 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnkI45V/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:02:46 INFO - 2015-11-28 22:02:46,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 139218944 22:02:46 INFO - 2015-11-28 22:02:46,525 DEBUG : BROWSER_OUTPUT: 22:03:36 INFO - 2015-11-28 22:03:36,135 DEBUG : BROWSER_OUTPUT: 1448777016134 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] 22:05:45 INFO - 2015-11-28 22:05:45,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49593/tests/dromaeo/cssquery-ext.html) 22:05:46 INFO - 2015-11-28 22:05:46,872 DEBUG : BROWSER_OUTPUT: RSS: Main: 144928768 22:05:46 INFO - 2015-11-28 22:05:46,872 DEBUG : BROWSER_OUTPUT: 22:08:48 INFO - 2015-11-28 22:08:48,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-ext.html (next: http://localhost:49593/tests/dromaeo/cssquery-jquery.html) 22:08:49 INFO - 2015-11-28 22:08:49,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 145448960 22:08:49 INFO - 2015-11-28 22:08:49,452 DEBUG : BROWSER_OUTPUT: 22:11:51 INFO - 2015-11-28 22:11:51,156 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49593/tests/dromaeo/cssquery-mootools.html) 22:11:51 INFO - 2015-11-28 22:11:51,738 DEBUG : BROWSER_OUTPUT: RSS: Main: 143048704 22:11:51 INFO - 2015-11-28 22:11:51,738 DEBUG : BROWSER_OUTPUT: 22:14:53 INFO - 2015-11-28 22:14:53,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49593/tests/dromaeo/cssquery-prototype.html) 22:14:53 INFO - 2015-11-28 22:14:53,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 142508032 22:14:53 INFO - 2015-11-28 22:14:53,958 DEBUG : BROWSER_OUTPUT: 22:17:56 INFO - 2015-11-28 22:17:56,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49593/tests/dromaeo/cssquery-yui.html) 22:17:56 INFO - 2015-11-28 22:17:56,939 DEBUG : BROWSER_OUTPUT: RSS: Main: 143425536 22:17:56 INFO - 2015-11-28 22:17:56,940 DEBUG : BROWSER_OUTPUT: 22:20:59 INFO - 2015-11-28 22:20:59,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/dromaeo/cssquery-yui.html (next: http://localhost:49593/tests/dromaeo/cssquery-dojo.html) 22:20:59 INFO - 2015-11-28 22:20:59,580 DEBUG : BROWSER_OUTPUT: RSS: Main: 145559552 22:20:59 INFO - 2015-11-28 22:20:59,580 DEBUG : BROWSER_OUTPUT: 22:20:59 INFO - 2015-11-28 22:20:59,580 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:20:59 INFO - 2015-11-28 22:20:59,580 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:20:59 INFO - 2015-11-28 22:20:59,580 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:20:59 INFO - 2015-11-28 22:20:59,581 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:20:59 INFO - 2015-11-28 22:20:59,581 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3252.983735081325;3293.5553700250457;3316.452785290427;3339.5825521809775;3345.9498107528393;5372.247885296052;5516.448355164482;5520.702634880805;5523.502884740373;5530.751116199771;5421.593380496459;5486.012517746814;5607.467290607386;5709.600327977043;5716.028275193216;5019.272205530205;5081.339425874631;5141.948580514184;5164.941187056645;5166.741662916858;5072.543471087602;5075.720835354054;5114.641975061747;5136.126858434057;5172.198309262051;4965.404151501807;5025.3718285214345;5084.059449001909;5092.821751238707;5112.590992720592;5051.444341122474;5077.111505486562;5085.5931525478245;5088.23676448532;5106.5659418949435;5072.442031376546;5085.669431486942;5090.261912022736;5094.235864620299;5099.260607211971;5178.97410512945;5237;5323.680579165262;5372.946270537283;5408.432114627947;5980.43185897339;6070.726817293233;6074.787382441637;6079.240094988127;6079.544034197409;6066.908996365058;6074.301455332605;6074.8785024299705;6088.512918966472;6090.817275481699;5510.173473978895;5523.613347065707;5575.637583557056;5583.4974852263085;5603.80386686464;6073.0283154695035;6085.513158947274;6094.146819445281;6112.266528016667;6119.418655227746;5763.510101641407;5884.146798714162;5888.941110588839;5890.9410905891245;5894.410558944071;5946.524278057832;5994.460498555151;6071.453569178707;6109.2528441424865;6132.17215675878;5961.880762384728;5969.492593129546;6012.248468941382;6016.578839481194;6020.668863212478;5760;5863.736131874076;6025.0661147522205;6025.698715064317;6037.788677396358;4539.387182730356;4584.060267645124;4585.358049873021;4619.168549661026;4632.02727427244;4113.753174809521;4120.093579412524;4123.711340206157;4129.2773764591075;4162.021924847659;5655.971720141455;5744.253247077937;5768.394318596487;5782.132680098019;5784.942150578525;5908.350081491032;5975.25309336333;5976.760929562855;6010.639361638316;6049.8487537811025;5694.174344720075;5698.914516282176;5701.287339082614;5718.542516598662;5732.598718089694;5057.519535644108;5146.022255771391;5147.819826306136;5152.3044389007755;5210.140326846028;6055.061465472859;6131.315499378962;6132.324915438597;6142.590862071594;6145.231846019247;5979.1928089707335;6048.213732214784;6052.90920636182;6059.3334733178435;6066.757329706762;6006.669633170218;6076.72654730547;6210.689465526796;6211.534134939988;6220.222472190976;5816.331121921034;5836.766529338779;5843.181954526284;5922.466977971831;5968.164456976114;5946.940530594812;5972.581919265784;6009.909851352146;6019.969900150471;6021.066734656135;5572.526335261548;5878.147668588116;5883.0293001654245;5891.911621325769;5897.292324921037;5785.074388097884;5795.797147099831;5859.765609375577;5883.235179426647;5930.140129681258;5744.080947048452;5783.219265399117;5786.884262314646;5793.710314484343;5805.82582522525;5731.197632331394;5843.883122337615;5868.765249389977;5960.4635582797755;5963.940360596512;5670.914936276042;5767.307923049261;5774.249347584787;5777.191193233035;5819.098039803837 22:20:59 INFO - 2015-11-28 22:20:59,581 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.1994597860114;610.2554883042687;612.4855121697773;621.0994058615008;628.7924984755032;39328;40282.59717402825;40311.79844100779;40339.19321613566;40395.394069088914;42899;42987.140257194835;43401.782991085;43533.782331088376;43560.12879742411;8807.515586642716;8999.955000224989;9001.549922503882;9007.729768106967;9024.413413128159;8751.16863897932;8839.07189745074;8843.425177363482;8854.07032261613;8857.822843543157;8786.64853405863;8850.380473366868;8854.601542930584;8863.290936725047;8863.601137948775;8795.296376289882;8858.557072146366;8881.866771998426;8897.421667591585;8915.821683566357;8740.8688869667;8775.078616745213;8850.867236991451;8869.157430044135;8873.11268873114;39993.60006399928;40472;40606.39090413646;40655.593444065475;40693.59306406957;3282.4091663500562;3347.2301370684636;3648.8175591220597;3721.3301605710963;4001.4598029265967;29832;29897;30253;30253.24366890823;30659;3821.9617803821884;3833.5974722654;3877.8448862045484;3914.921701565981;3948.4866967294356;244950;247356;248829;249416;252141;55945.16082258769;56649.43350566524;56740;56891.431085689444;57023.58275963777;68789;70523.64738176276;70588.64705676438;70649;70690.64654676693;14080.366383512766;14111.647208819657;14120.71758564823;14144.504942326968;14268.14391136535;11222.887771122347;11259.605913792979;11298.435078246055;11311.886881131248;11360.48877800501;19663.60672786565;19971.700424493643;20030.298939537046;20060.89969550143;20072.197112115642;7749.418793590503;7868.763937081897;7928.960355198187;7961.243681850215;8047.171696981764;985.6205360935948;997.6907158780801;999.5302207962392;1019.2304809868501;1045.2213101239472;28163;28361.43277134487;28631.14106576806;28693.413323334582;28758.568621470695;1069.2889228662852;1086.3047649504324;1119.8880111988735;1145.3929417408788;1203.0676225924803;14603.196824174773;14696.619777451246;15003;15060.623484412978;15228.46700365504;301845;302245;303720;305413;305812;51371.22943155855;51635.741821290656;51885.22172167421;51995.48004519982;52050.21924671133;1335.105479328852;1351.8512963574196;1355.7017456159826;1362.7615167345675;1469.4489566412594;27193.72806271991;28263.858680706464;28486.57270140908;29615.703842961295;30915.536266956464;47939.520604793506;48679;48704.26943595778;48742;48797.75601121972;264504;266364;266770;266785;267050;31892.36215275728;32132.83933580317;32362.190945226557;32500.187495312806;32561.674383255864;38233;38723.612763872;38786.41820372753;39253.2149357017;39953.20093598054;33056.50415243725;34987.47518787271;35817.81981085117;36337;36477.81761091178;35763.284734305686;35945.820270898475;36047;36055;36083;35464;35909.820450898624;36020;36085.45871811977;36302.455463168604;30579.847100764353;32061.03816885497;32664.34671306513;32708.672913271515;32786.67213327836;25073;25242.49515009653;25336.927223719587;25601.74398256068;25715.228543143734 22:20:59 INFO - 2015-11-28 22:20:59,584 DEBUG : BROWSER_OUTPUT: |2;jquery.html;355.87544359474185;356.64157521690714;357.80486714009544;358.1511816993725;360.55831606282305;16480.67038659226;16641.750373744402;17130.31478740849;17385.82614173858;18049.81950180501;11253;11285.435728213577;11320.943395283033;12275.017998560115;16030.118343491104;4997.075541024922;5011.974940125294;5090.236464530331;5108.667936584129;5173.379194496647;5088.287639730423;5113.769880355374;5125.820596279131;5128.230765385203;5129.820456284031;4989.775460104286;5109.974450127745;5122.282880396748;5211.557017653485;5330.813421530247;5266.473352664722;5269.499397557264;5274.472552744734;5304.496072873071;5345.946540534604;5118.667286626394;5266.60500462463;5269.6311258211945;5306.204069389584;5311.150215965466;12898.87101128986;13129.868701313055;16339;20341.593168136555;20543.486412839648;2070.285751415759;2090.1325949730845;2090.2266161520333;2117.6611742121186;2201.152556265833;9573.712788616353;9980.950095249478;10962.671119866416;11164.883511648852;13559.322033898266;1730.3943619732993;1767.4079183473552;1836.8530517558563;1898.250191174492;2027.3715148304072;60082;64014.039789403665;64646;64884.675576622285;65637.3436265636;10441.112505437122;10476.371417714961;10482.318649287772;10513.421761803174;10603.946980265204;13578.796318055238;13645.727085458235;13675;13723.931380343234;13762.24307663088;7568.675481790665;7643.885341719767;7654.464187506933;7687.654055567513;7699.037620297463;7391.223921488274;7410.296021877913;7414.369778568775;7451;7472.589007604525;4468.843590474383;4494.325851122292;4513.345564893072;4538.205813982539;4565.977170114128;1810.8641851861164;1847.5658419792605;1849.5930895203303;1858.851291896645;1869.6634605770819;397.01738197959816;425.15394365213;425.90842968761245;439.58678841888525;466.8272739086492;10782.67651970442;11284.830727539094;11443;11482.598109066143;11485.138614603939;829.4815740162398;920.2408013388981;943.165298710646;970.4371464550544;1016.9237307201842;9371.390859594105;9625;10073.345232559861;10074.59701611942;10079.193664506822;529467;531314;534185;542122;548547;75701;76279;78285;78332.60833695909;79724;1169.4094482286391;1185.7154282972197;1190.398848581461;1193.3555879824971;1193.4689063366718;15264.694706106038;15432.84567154314;15541.844581554493;15594.376224950875;15686.843131568538;34320.313593727486;34400.311993760486;35198.824005879804;35526.82236588904;36013.0996725084;46633.3005004932;47546.762266188445;47554.52445475501;47733.76133119312;50330.2450463236;9624.085711857362;9678.854817177607;9768;9805.509724513604;9865.802683946138;13736.313184340543;16887.831121689116;17028;17564.73652895182;17664.823351766318;9403.811923761623;9640.699206803205;9733.805323893625;14506.85493145055;14588.270586470422;9564.76088097803;10213.540390682288;10222.233332499944;10393;10480.790384192425;10797.946010269898;10822.458877056273;11004.779904401707;11028.558857645605;11057.447127643425;13435.664108397368;14105.435782568582;15150.090994540364;15177.772333414787;15830.208489575705;16139.75790363169;16282.918585406996;16566.83433165653;16676.08281544527;16747.581310467336 22:20:59 INFO - 2015-11-28 22:20:59,584 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1396.1204441202044;1442.9855701442987;1586.2068965517242;1638.3528506240043;1746.414950991417;7266.491345605809;7315.195328513859;7411.332980031796;7864.8427031459405;7886.723964661245;7645.15903250642;7825.452218344718;7925.920740792591;7931.087924888625;7955.681772729098;2277.954440911177;2294.0365046680436;2312.676225328447;2314.4329639238326;2314.5602335556273;2280.783325584067;2319.9536009279805;2331.825113116515;2345.1909091363455;2353.5528249632516;2289.748127705951;2289.9656505152434;2334.031376978552;2336.0655737704883;2338.924094916332;2253.86476811391;2258.5369999150134;2277.373722226401;2277.5558766040544;2280.8745518996448;2309.3418375762826;2314.849534780251;2316.7683231676865;2330.9300720978226;2333.696619439479;7851.45039847211;7897.131315555284;7955.96022019892;7978.960105199495;7999;4713.245880659112;4759.262314341283;4803.3995750531185;4806.639502037361;4824.372831531913;3043.5434684797237;3050.0544831102206;3098.148009297439;3109.207152176203;3139.780215384924;1008.9949550252276;1018.9337693049928;1028.4703377760459;1042.0413219837767;1900.3633782682818;10452.477376131163;10494.265401421904;10589.417582032986;10591.099756520627;10614.363138211655;4168.187203495289;4214.662826973835;4264.552222016706;4303.33298338758;4313.352997050405;8382;8387.203215694499;8395.328373730086;8408.663653453794;8412.831743365221;4726.621870250372;4728.645351598575;4732.148213321635;4739.218029025241;4789.090072886141;4328.523862375137;4372.191144638252;4394.604485596312;4402.405675233803;4414.58061484165;3594.2092739597247;3607.206414588786;3630.09247688078;3638.1268495561403;3670.3026424979703;1122.7361570031037;1123.6179698902413;1124.224285243196;1124.9268797528134;1132.4960392625203;1052.2371280821496;1067.386252904583;1069.1072954083272;1258.5154715434624;1368.0423703407655;7546.962265188639;7608.80977975555;7620.771376858703;7624.390048796083;7627.046619172604;482.2862163997304;488.1213815132747;489.9632527560447;491.42503271172814;494.88865005373503;5889;5919.1713160157615;5983.072623743326;5984.491318237911;6002.339742628307;9106;9510.429374237568;9510.90489095114;9544.236461083097;9671.90328096724;9401.623935042522;9425.622975081056;9431.76420589477;9432.292578056673;9530;7351.485396022227;7414.703411863573;7466.813329666693;7485.101787785392;7492.587907665131;7116.679749411185;7180.964095179491;7201.963990180016;7230.168530619047;7244.239354867663;8386.161383861565;8390.832183356177;8490.91509084926;8498.490090594583;8575.3997220194;8575;8698.173673501007;8711.25954293892;8745.781355466164;8759.956200218958;6453.9354606453335;6742.292059333896;6861.519693621399;6940.861182776215;6964.199117101395;7371.852562948604;7378.040854688856;7399.704011839466;7406.555606663617;7465.7013719450615;7135.286471352823;7185.425165986813;7190.604516751629;7301.634918254173;7437.888431673421;6961.582305061713;6969.721211151497;7043.506954513135;7066.434685225273;7090.113735783028;7173.641317933978;7295.306945840137;7354.558726476428;7374.631268436664;7380.298871607403;6661.933380666325;6695.799126026227;6703.229128650268;6751.257361690308;6797.93202067973;6505.674716264073;6604.603723776589;6678.933210667831;6899.827504312231;6903.413209877217 22:20:59 INFO - 2015-11-28 22:20:59,588 DEBUG : BROWSER_OUTPUT: |4;prototype.html;336.18642884220185;338.9135770378553;346.35059263880214;348.1192582765604;348.5375819832879;6150.292716337623;6290.4653104486115;6317.084022816694;6332.050192471132;6379;6123.785667501638;6239.688015599225;6258.123862659231;6271.968640156792;6273.3412991635905;4806.7115973041555;4809.110314591794;4818.566329030386;4821.228603423436;4826.276058591205;4818.34952281441;4820.927686084711;4827.975860120694;4828.299896515004;4833.734144622044;4694.953050469503;4777;4793.9520604794025;4794.472608013116;4803.423589169304;4765.523447655241;4772.284157376386;4780.928286075712;4784.330193772875;4789.2816077588295;4195.307774217251;4210.978945105286;4212.115455754295;4213.789310534492;4236.4704411948505;5932.644041357532;5932.911006334908;5943.673097979609;5944.10838374243;5944.286685597756;5485.780568777244;5607.4112218217315;5628.296462942132;5640.505266104486;5643.915341269884;6621.106150669694;6633.701483433257;6640.8671826563195;6658.334166583351;6664.366885145903;4679.15775160471;4693.78877950493;4701.529847015271;4701.7414042227665;4708.152532544141;6793.694283757193;6937.132858392701;6947.3747362737595;6985.511014228955;7024.508284420092;4670.69640473375;4696.483386827446;4701.1537923174155;4703.553162449562;4725.598324142417;4746.28805679144;4751.928721069186;4753.524647535219;4755.310479980383;4776.95223047772;5508.118701007819;5517.2551705520045;5547.5007249346945;5551.666899986014;5556.388797232301;6582.275949645536;6735.360140786617;6736.854734695114;6746.797596072126;6750.459963202932;1637.3859802574034;1676.1702957036346;1683.166832417961;1684.0485125903824;1686.6289416328389;1107.534835369147;1121.4224674292745;1126.059740116995;1133.8525991621202;1135.8296255561568;6417.7753778617525;6420;6420.945297504753;6434.678266086677;6443.420092191725;6844.315568443216;6852.109225800614;6866.416354609814;6870.416014638712;6871.175458944958;6373.553851230462;6373.872522549523;6395.392437718409;6438.742450301936;6442.130312407859;3801.0497375656087;3816.9618303816605;3823.923521529554;3823.9808800955816;3826.3877779555137;7200.315969982948;7318.3047610476915;7324.535092981425;7328.560286382834;7336.559806411632;7051.92948070523;7141.285871412817;7168.960500727365;7194.64026798658;7206.171290301682;7226.819329516699;7253.093363329584;7276.599787011659;7285.198628150899;7325.340719335285;6928.757493487704;6933.37599616037;6943.444524438134;6970.825729356604;6977.79066628002;6712.765053223114;6839.794806155824;6845.897311540231;6885.862282754217;6901.89647155283;7267.236940121423;7274.527155734861;7277.636118193963;7279.708811647687;7290.234525374759;4605.585497305125;4633.606143477842;4643.233866412004;4648.325992731103;4650.534946505322;6627.5360724750735;6785.219699734396;6811.557248778813;6949.339812717783;6963.40811031068;6584.111144995556;6682;6710.496712746662;6746.359095885883;6785.558938668971;6745.055692202997;6789.728410863708;6796.150481189851;6796.558223715443;6797.116374871235;6412;6607.471402287902;6624.470042396693;6626.83432914181;6654.201495820533;6766.492513061638;6770.796876093725;6774.593524388552;6789.15135608049;6797.66011699423;6626.469882409492;6629.370209830058;6632.369924857131;6635.933640663531;6659.500537459613 22:20:59 INFO - 2015-11-28 22:20:59,589 DEBUG : BROWSER_OUTPUT: |5;yui.html;813.4875028731898;814.7107776739256;849.9320054395649;866.1987661413191;866.5104216117888;12803.359832008397;12904.612861614154;12983.156094853828;13468.25924574148;13534.052616316862;13440.865591344083;13455.192688438701;13455.663608409795;13509.256990865499;13587.320633968287;677.3226773226774;684.03209458616;815.9102498725135;818.30444122496;829.8838162657232;826.7023871406288;826.983460330793;834.328365665642;834.6536187482218;834.6869923778584;875.1467319363601;876.3514998900799;877.8814859993882;880.2385936165235;881.4887365328126;866.8353012927555;867.8307729992654;868.7263511993701;872.1540106097076;872.2019352292644;637.3085202555233;637.9553431259814;638.4286063972719;639.6961443314435;640.4972096903955;13616;13617.591472255848;13703.314834258248;13735.175889446666;13738.519151829738;11577.189596728233;11708.707282317924;11781.293122412682;11832.70418239551;11869.228500147463;10212.642557510451;10256.128229100535;10290.588376464932;10377.429241391721;10426;3568.4468907319406;3597.172650290448;3611.7652352596997;3612.259486805199;3751.4747935289083;49274.50725492771;49797.75101124471;49822.750886245696;49857.50142498565;49961.75019124917;10153.898461015444;10252.692419227435;10327.690169294932;10341.896581034243;10620.150387968944;19063.90468047651;19073.332433364765;19094.809051909582;19123.80876191248;19127.61744765097;7849.529028258323;7978.441509094308;7993.480423772437;8009.479383840032;8185.058718247358;4293.677974151951;4341.044970106572;4408.735475871458;4441.178381999341;4488.079943611552;3060.816351018946;3072.1858707442548;3091.458994675923;3096.34976654905;3103.0380582019193;536.5707434052742;559.0440347006664;566.2073097663305;566.334556895646;567.1974156568492;545.1005840363352;597.8924786715294;659.2226541914855;679.6533767778468;698.078536332047;8401.201885820838;8443.915560844436;8549.829003420022;8594.546949124075;8685.218330350172;702.6381413572014;709.393468584353;711.2226754523593;721.3579913876654;730.5288089182554;4032.9395059074136;4209.989602495379;4283.850065247701;4346.913061738747;4477.686561940698;60860.39139608547;61412.078818817754;61890.69054654788;62232.68883655643;62268.68865655734;53614.7319263409;53702.731486342316;53790.19314710282;53893.461065388845;54342.18486722702;49846;50010;50600;50689.493105068475;51545.48454515407;8416.3266938646;8537.573121344032;8576.614052367533;8675.219230269306;8916.687915922912;36800.26399472049;36994.44508332323;37202;37612.811935940146;37639;43570;44042.33936491019;48842.26736599025;48989;49099.75450122727;10990.615328463466;11119.27724697892;11348.602798901999;11349.773004540028;11662.53349865996;12364.690882728004;12697.55558555446;12717.682057948625;13095.214287142802;13136.080474366703;11852.70368240801;11853.143043904538;11962.58130965412;11963.527280287766;11981.820272696092;11719.88280117188;11988.76022479528;12075.698107547381;12094.213876098025;12481.875181248071;10611.151107911503;10894.128469722245;10990.725231868948;11296.943515282699;11342.546298147981;9625;9701.805963880824;9806.75483112928;10002.699919002442;10496.16030717556;8555.443896146731;8919.93444457775;9130.726078217664;10010.44942528168;10014.449205293779 22:20:59 INFO - 2015-11-28 22:20:59,589 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:20:59 INFO - 2015-11-28 22:20:59,589 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:20:59 INFO - 2015-11-28 22:20:59,589 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,308 22:20:59 INFO - 2015-11-28 22:20:59,589 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:20:59 INFO - 2015-11-28 22:20:59,589 DEBUG : BROWSER_OUTPUT: __startTimestamp1448778059579__endTimestamp 22:20:59 INFO - 2015-11-28 22:20:59,590 DEBUG : BROWSER_OUTPUT: 22:20:59 INFO - 2015-11-28 22:20:59,590 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:20:59 INFO - 2015-11-28 22:20:59,590 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:20:59 INFO - 2015-11-28 22:20:59,590 DEBUG : BROWSER_OUTPUT: 22:20:59 INFO - 2015-11-28 22:20:59,590 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5556.78 Median:5782.13 stddev:623.11 (10.8%) stddev-sans-first:598.24 22:20:59 INFO - 2015-11-28 22:20:59,590 DEBUG : BROWSER_OUTPUT: Values: 3253.0 3293.6 3316.5 3339.6 3345.9 5372.2 5516.4 5520.7 5523.5 5530.8 5421.6 5486.0 5607.5 5709.6 5716.0 5019.3 5081.3 5141.9 5164.9 5166.7 5072.5 5075.7 5114.6 5136.1 5172.2 4965.4 5025.4 5084.1 5092.8 5112.6 5051.4 5077.1 5085.6 5088.2 5106.6 5072.4 5085.7 5090.3 5094.2 5099.3 5179.0 5237.0 5323.7 5372.9 5408.4 5980.4 6070.7 6074.8 6079.2 6079.5 6066.9 6074.3 6074.9 6088.5 6090.8 5510.2 5523.6 5575.6 5583.5 5603.8 6073.0 6085.5 6094.1 6112.3 6119.4 5763.5 5884.1 5888.9 5890.9 5894.4 5946.5 5994.5 6071.5 6109.3 6132.2 5961.9 5969.5 6012.2 6016.6 6020.7 5760.0 5863.7 6025.1 6025.7 6037.8 4539.4 4584.1 4585.4 4619.2 4632.0 4113.8 4120.1 4123.7 4129.3 4162.0 5656.0 5744.3 5768.4 5782.1 5784.9 5908.4 5975.3 5976.8 6010.6 6049.8 5694.2 5698.9 5701.3 5718.5 5732.6 5057.5 5146.0 5147.8 5152.3 5210.1 6055.1 6131.3 6132.3 6142.6 6145.2 5979.2 6048.2 6052.9 6059.3 6066.8 6006.7 6076.7 6210.7 6211.5 6220.2 5816.3 5836.8 5843.2 5922.5 5968.2 5946.9 5972.6 6009.9 6020.0 6021.1 5572.5 5878.1 5883.0 5891.9 5897.3 5785.1 5795.8 5859.8 5883.2 5930.1 5744.1 5783.2 5786.9 5793.7 5805.8 5731.2 5843.9 5868.8 5960.5 5963.9 5670.9 5767.3 5774.2 5777.2 5819.1 22:20:59 INFO - 2015-11-28 22:20:59,590 DEBUG : BROWSER_OUTPUT: 22:20:59 INFO - 2015-11-28 22:20:59,590 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44934.47 Median:36193.96 stddev:71436.06 (197.4%) stddev-sans-first:71558.72 22:20:59 INFO - 2015-11-28 22:20:59,591 DEBUG : BROWSER_OUTPUT: Values: 550.2 610.3 612.5 621.1 628.8 39328.0 40282.6 40311.8 40339.2 40395.4 42899.0 42987.1 43401.8 43533.8 43560.1 8807.5 9000.0 9001.5 9007.7 9024.4 8751.2 8839.1 8843.4 8854.1 8857.8 8786.6 8850.4 8854.6 8863.3 8863.6 8795.3 8858.6 8881.9 8897.4 8915.8 8740.9 8775.1 8850.9 8869.2 8873.1 39993.6 40472.0 40606.4 40655.6 40693.6 3282.4 3347.2 3648.8 3721.3 4001.5 29832.0 29897.0 30253.0 30253.2 30659.0 3822.0 3833.6 3877.8 3914.9 3948.5 244950.0 247356.0 248829.0 249416.0 252141.0 55945.2 56649.4 56740.0 56891.4 57023.6 68789.0 70523.6 70588.6 70649.0 70690.6 14080.4 14111.6 14120.7 14144.5 14268.1 11222.9 11259.6 11298.4 11311.9 11360.5 19663.6 19971.7 20030.3 20060.9 20072.2 7749.4 7868.8 7929.0 7961.2 8047.2 985.6 997.7 999.5 1019.2 1045.2 28163.0 28361.4 28631.1 28693.4 28758.6 1069.3 1086.3 1119.9 1145.4 1203.1 14603.2 14696.6 15003.0 15060.6 15228.5 301845.0 302245.0 303720.0 305413.0 305812.0 51371.2 51635.7 51885.2 51995.5 52050.2 1335.1 1351.9 1355.7 1362.8 1469.4 27193.7 28263.9 28486.6 29615.7 30915.5 47939.5 48679.0 48704.3 48742.0 48797.8 264504.0 266364.0 266770.0 266785.0 267050.0 31892.4 32132.8 32362.2 32500.2 32561.7 38233.0 38723.6 38786.4 39253.2 39953.2 33056.5 34987.5 35817.8 36337.0 36477.8 35763.3 35945.8 36047.0 36055.0 36083.0 35464.0 35909.8 36020.0 36085.5 36302.5 30579.8 32061.0 32664.3 32708.7 32786.7 25073.0 25242.5 25336.9 25601.7 25715.2 22:20:59 INFO - 2015-11-28 22:20:59,591 DEBUG : BROWSER_OUTPUT: 22:20:59 INFO - 2015-11-28 22:20:59,591 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28451.15 Median:17777.35 stddev:87835.26 (494.1%) stddev-sans-first:88056.32 22:20:59 INFO - 2015-11-28 22:20:59,592 DEBUG : BROWSER_OUTPUT: Values: 355.9 356.6 357.8 358.2 360.6 16480.7 16641.8 17130.3 17385.8 18049.8 11253.0 11285.4 11320.9 12275.0 16030.1 4997.1 5012.0 5090.2 5108.7 5173.4 5088.3 5113.8 5125.8 5128.2 5129.8 4989.8 5110.0 5122.3 5211.6 5330.8 5266.5 5269.5 5274.5 5304.5 5345.9 5118.7 5266.6 5269.6 5306.2 5311.2 12898.9 13129.9 16339.0 20341.6 20543.5 2070.3 2090.1 2090.2 2117.7 2201.2 9573.7 9981.0 10962.7 11164.9 13559.3 1730.4 1767.4 1836.9 1898.3 2027.4 60082.0 64014.0 64646.0 64884.7 65637.3 10441.1 10476.4 10482.3 10513.4 10603.9 13578.8 13645.7 13675.0 13723.9 13762.2 7568.7 7643.9 7654.5 7687.7 7699.0 7391.2 7410.3 7414.4 7451.0 7472.6 4468.8 4494.3 4513.3 4538.2 4566.0 1810.9 1847.6 1849.6 1858.9 1869.7 397.0 425.2 425.9 439.6 466.8 10782.7 11284.8 11443.0 11482.6 11485.1 829.5 920.2 943.2 970.4 1016.9 9371.4 9625.0 10073.3 10074.6 10079.2 529467.0 531314.0 534185.0 542122.0 548547.0 75701.0 76279.0 78285.0 78332.6 79724.0 1169.4 1185.7 1190.4 1193.4 1193.5 15264.7 15432.8 15541.8 15594.4 15686.8 34320.3 34400.3 35198.8 35526.8 36013.1 46633.3 47546.8 47554.5 47733.8 50330.2 9624.1 9678.9 9768.0 9805.5 9865.8 13736.3 16887.8 17028.0 17564.7 17664.8 9403.8 9640.7 9733.8 14506.9 14588.3 9564.8 10213.5 10222.2 10393.0 10480.8 10797.9 10822.5 11004.8 11028.6 11057.4 13435.7 14105.4 15150.1 15177.8 15830.2 16139.8 16282.9 16566.8 16676.1 16747.6 22:20:59 INFO - 2015-11-28 22:20:59,592 DEBUG : BROWSER_OUTPUT: 22:20:59 INFO - 2015-11-28 22:20:59,592 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5493.00 Median:6479.81 stddev:2845.11 (43.9%) stddev-sans-first:2836.43 22:20:59 INFO - 2015-11-28 22:20:59,592 DEBUG : BROWSER_OUTPUT: Values: 1396.1 1443.0 1586.2 1638.4 1746.4 7266.5 7315.2 7411.3 7864.8 7886.7 7645.2 7825.5 7925.9 7931.1 7955.7 2278.0 2294.0 2312.7 2314.4 2314.6 2280.8 2320.0 2331.8 2345.2 2353.6 2289.7 2290.0 2334.0 2336.1 2338.9 2253.9 2258.5 2277.4 2277.6 2280.9 2309.3 2314.8 2316.8 2330.9 2333.7 7851.5 7897.1 7956.0 7979.0 7999.0 4713.2 4759.3 4803.4 4806.6 4824.4 3043.5 3050.1 3098.1 3109.2 3139.8 1009.0 1018.9 1028.5 1042.0 1900.4 10452.5 10494.3 10589.4 10591.1 10614.4 4168.2 4214.7 4264.6 4303.3 4313.4 8382.0 8387.2 8395.3 8408.7 8412.8 4726.6 4728.6 4732.1 4739.2 4789.1 4328.5 4372.2 4394.6 4402.4 4414.6 3594.2 3607.2 3630.1 3638.1 3670.3 1122.7 1123.6 1124.2 1124.9 1132.5 1052.2 1067.4 1069.1 1258.5 1368.0 7547.0 7608.8 7620.8 7624.4 7627.0 482.3 488.1 490.0 491.4 494.9 5889.0 5919.2 5983.1 5984.5 6002.3 9106.0 9510.4 9510.9 9544.2 9671.9 9401.6 9425.6 9431.8 9432.3 9530.0 7351.5 7414.7 7466.8 7485.1 7492.6 7116.7 7181.0 7202.0 7230.2 7244.2 8386.2 8390.8 8490.9 8498.5 8575.4 8575.0 8698.2 8711.3 8745.8 8760.0 6453.9 6742.3 6861.5 6940.9 6964.2 7371.9 7378.0 7399.7 7406.6 7465.7 7135.3 7185.4 7190.6 7301.6 7437.9 6961.6 6969.7 7043.5 7066.4 7090.1 7173.6 7295.3 7354.6 7374.6 7380.3 6661.9 6695.8 6703.2 6751.3 6797.9 6505.7 6604.6 6678.9 6899.8 6903.4 22:20:59 INFO - 2015-11-28 22:20:59,592 DEBUG : BROWSER_OUTPUT: 22:20:59 INFO - 2015-11-28 22:20:59,592 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5607.08 Median:6376.44 stddev:1703.98 (26.7%) stddev-sans-first:1662.20 22:20:59 INFO - 2015-11-28 22:20:59,593 DEBUG : BROWSER_OUTPUT: Values: 336.2 338.9 346.4 348.1 348.5 6150.3 6290.5 6317.1 6332.1 6379.0 6123.8 6239.7 6258.1 6272.0 6273.3 4806.7 4809.1 4818.6 4821.2 4826.3 4818.3 4820.9 4828.0 4828.3 4833.7 4695.0 4777.0 4794.0 4794.5 4803.4 4765.5 4772.3 4780.9 4784.3 4789.3 4195.3 4211.0 4212.1 4213.8 4236.5 5932.6 5932.9 5943.7 5944.1 5944.3 5485.8 5607.4 5628.3 5640.5 5643.9 6621.1 6633.7 6640.9 6658.3 6664.4 4679.2 4693.8 4701.5 4701.7 4708.2 6793.7 6937.1 6947.4 6985.5 7024.5 4670.7 4696.5 4701.2 4703.6 4725.6 4746.3 4751.9 4753.5 4755.3 4777.0 5508.1 5517.3 5547.5 5551.7 5556.4 6582.3 6735.4 6736.9 6746.8 6750.5 1637.4 1676.2 1683.2 1684.0 1686.6 1107.5 1121.4 1126.1 1133.9 1135.8 6417.8 6420.0 6420.9 6434.7 6443.4 6844.3 6852.1 6866.4 6870.4 6871.2 6373.6 6373.9 6395.4 6438.7 6442.1 3801.0 3817.0 3823.9 3824.0 3826.4 7200.3 7318.3 7324.5 7328.6 7336.6 7051.9 7141.3 7169.0 7194.6 7206.2 7226.8 7253.1 7276.6 7285.2 7325.3 6928.8 6933.4 6943.4 6970.8 6977.8 6712.8 6839.8 6845.9 6885.9 6901.9 7267.2 7274.5 7277.6 7279.7 7290.2 4605.6 4633.6 4643.2 4648.3 4650.5 6627.5 6785.2 6811.6 6949.3 6963.4 6584.1 6682.0 6710.5 6746.4 6785.6 6745.1 6789.7 6796.2 6796.6 6797.1 6412.0 6607.5 6624.5 6626.8 6654.2 6766.5 6770.8 6774.6 6789.2 6797.7 6626.5 6629.4 6632.4 6635.9 6659.5 22:20:59 INFO - 2015-11-28 22:20:59,593 DEBUG : BROWSER_OUTPUT: 22:20:59 INFO - 2015-11-28 22:20:59,593 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14375.02 Median:26665.17 stddev:16977.96 (63.7%) stddev-sans-first:16995.04 22:20:59 INFO - 2015-11-28 22:20:59,593 DEBUG : BROWSER_OUTPUT: Values: 813.5 814.7 849.9 866.2 866.5 12803.4 12904.6 12983.2 13468.3 13534.1 13440.9 13455.2 13455.7 13509.3 13587.3 677.3 684.0 815.9 818.3 829.9 826.7 827.0 834.3 834.7 834.7 875.1 876.4 877.9 880.2 881.5 866.8 867.8 868.7 872.2 872.2 637.3 638.0 638.4 639.7 640.5 13616.0 13617.6 13703.3 13735.2 13738.5 11577.2 11708.7 11781.3 11832.7 11869.2 10212.6 10256.1 10290.6 10377.4 10426.0 3568.4 3597.2 3611.8 3612.3 3751.5 49274.5 49797.8 49822.8 49857.5 49961.8 10153.9 10252.7 10327.7 10341.9 10620.2 19063.9 19073.3 19094.8 19123.8 19127.6 7849.5 7978.4 7993.5 8009.5 8185.1 4293.7 4341.0 4408.7 4441.2 4488.1 3060.8 3072.2 3091.5 3096.3 3103.0 536.6 559.0 566.2 566.3 567.2 545.1 597.9 659.2 679.7 698.1 8401.2 8443.9 8549.8 8594.5 8685.2 702.6 709.4 711.2 721.4 730.5 4032.9 4210.0 4283.9 4346.9 4477.7 60860.4 61412.1 61890.7 62232.7 62268.7 53614.7 53702.7 53790.2 53893.5 54342.2 49846.0 50010.0 50600.0 50689.5 51545.5 8416.3 8537.6 8576.6 8675.2 8916.7 36800.3 36994.4 37202.0 37612.8 37639.0 43570.0 44042.3 48842.3 48989.0 49099.8 10990.6 11119.3 11348.6 11349.8 11662.5 12364.7 12697.6 12717.7 13095.2 13136.1 11852.7 11853.1 11962.6 11963.5 11981.8 11719.9 11988.8 12075.7 12094.2 12481.9 10611.2 10894.1 10990.7 11296.9 11342.5 9625.0 9701.8 9806.8 10002.7 10496.2 8555.4 8919.9 9130.7 10010.4 10014.4 22:20:59 INFO - 2015-11-28 22:20:59,594 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:20:59 INFO - 2015-11-28 22:20:59,594 DEBUG : BROWSER_OUTPUT: 22:21:00 INFO - 2015-11-28 22:21:00,233 INFO : Browser exited with error code: 0 22:21:00 INFO - 2015-11-28 22:21:00,254 INFO : Completed test dromaeo_css (00:18:30) 22:21:00 INFO - 2015-11-28 22:21:00,254 INFO : Starting test kraken 22:21:00 INFO - 2015-11-28 22:21:00,255 DEBUG : operating with platform_type : linux_ 22:21:00 INFO - 2015-11-28 22:21:00,255 INFO : Initialising browser for kraken test... 22:21:00 INFO - 2015-11-28 22:21:00,261 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYaDnJZ/profile http://localhost:49593/getInfo.html 22:21:04 INFO - 2015-11-28 22:21:04,204 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:21:04 INFO - 2015-11-28 22:21:04,204 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:21:04 INFO - 2015-11-28 22:21:04,204 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:21:04 INFO - 2015-11-28 22:21:04,204 DEBUG : BROWSER_OUTPUT: __metrics 22:21:05 INFO - 2015-11-28 22:21:05,197 INFO : Browser initialized. 22:21:05 INFO - 2015-11-28 22:21:05,198 INFO : Running cycle 1/1 for kraken test... 22:21:05 INFO - 2015-11-28 22:21:05,198 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYaDnJZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:21:16 INFO - 2015-11-28 22:21:16,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 138620928 22:21:16 INFO - 2015-11-28 22:21:16,953 DEBUG : BROWSER_OUTPUT: 22:21:19 INFO - 2015-11-28 22:21:19,433 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49593/tests/kraken/driver.html?testName=audio-beat-detection) 22:21:20 INFO - 2015-11-28 22:21:20,046 DEBUG : BROWSER_OUTPUT: RSS: Main: 141283328 22:21:20 INFO - 2015-11-28 22:21:20,046 DEBUG : BROWSER_OUTPUT: 22:21:22 INFO - 2015-11-28 22:21:22,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49593/tests/kraken/driver.html?testName=audio-dft) 22:21:23 INFO - 2015-11-28 22:21:23,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 141316096 22:21:23 INFO - 2015-11-28 22:21:23,309 DEBUG : BROWSER_OUTPUT: 22:21:26 INFO - 2015-11-28 22:21:26,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49593/tests/kraken/driver.html?testName=audio-fft) 22:21:26 INFO - 2015-11-28 22:21:26,738 DEBUG : BROWSER_OUTPUT: RSS: Main: 135598080 22:21:26 INFO - 2015-11-28 22:21:26,738 DEBUG : BROWSER_OUTPUT: 22:21:28 INFO - 2015-11-28 22:21:28,681 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49593/tests/kraken/driver.html?testName=audio-oscillator) 22:21:29 INFO - 2015-11-28 22:21:29,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 135815168 22:21:29 INFO - 2015-11-28 22:21:29,295 DEBUG : BROWSER_OUTPUT: 22:21:31 INFO - 2015-11-28 22:21:31,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49593/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:21:32 INFO - 2015-11-28 22:21:32,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 137113600 22:21:32 INFO - 2015-11-28 22:21:32,081 DEBUG : BROWSER_OUTPUT: 22:21:35 INFO - 2015-11-28 22:21:35,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49593/tests/kraken/driver.html?testName=imaging-darkroom) 22:21:35 INFO - 2015-11-28 22:21:35,625 DEBUG : BROWSER_OUTPUT: RSS: Main: 138743808 22:21:35 INFO - 2015-11-28 22:21:35,625 DEBUG : BROWSER_OUTPUT: 22:21:39 INFO - 2015-11-28 22:21:39,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49593/tests/kraken/driver.html?testName=imaging-desaturate) 22:21:39 INFO - 2015-11-28 22:21:39,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 138596352 22:21:39 INFO - 2015-11-28 22:21:39,608 DEBUG : BROWSER_OUTPUT: 22:21:42 INFO - 2015-11-28 22:21:42,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49593/tests/kraken/driver.html?testName=json-parse-financial) 22:21:43 INFO - 2015-11-28 22:21:43,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 138956800 22:21:43 INFO - 2015-11-28 22:21:43,069 DEBUG : BROWSER_OUTPUT: 22:21:44 INFO - 2015-11-28 22:21:44,676 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49593/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:21:45 INFO - 2015-11-28 22:21:45,245 DEBUG : BROWSER_OUTPUT: RSS: Main: 137789440 22:21:45 INFO - 2015-11-28 22:21:45,245 DEBUG : BROWSER_OUTPUT: 22:21:47 INFO - 2015-11-28 22:21:47,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:21:47 INFO - 2015-11-28 22:21:47,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 137547776 22:21:47 INFO - 2015-11-28 22:21:47,711 DEBUG : BROWSER_OUTPUT: 22:21:49 INFO - 2015-11-28 22:21:49,804 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:21:50 INFO - 2015-11-28 22:21:50,393 DEBUG : BROWSER_OUTPUT: RSS: Main: 138977280 22:21:50 INFO - 2015-11-28 22:21:50,393 DEBUG : BROWSER_OUTPUT: 22:21:52 INFO - 2015-11-28 22:21:52,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:21:53 INFO - 2015-11-28 22:21:53,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 137793536 22:21:53 INFO - 2015-11-28 22:21:53,441 DEBUG : BROWSER_OUTPUT: 22:21:56 INFO - 2015-11-28 22:21:56,056 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:21:56 INFO - 2015-11-28 22:21:56,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 138784768 22:21:56 INFO - 2015-11-28 22:21:56,644 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-28 22:21:58,332 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49593/tests/kraken/driver.html?testName=ai-astar) 22:21:58 INFO - 2015-11-28 22:21:58,582 DEBUG : BROWSER_OUTPUT: RSS: Main: 138240000 22:21:58 INFO - 2015-11-28 22:21:58,582 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-28 22:21:58,582 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:21:58 INFO - 2015-11-28 22:21:58,582 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:21:58 INFO - 2015-11-28 22:21:58,583 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:21:58 INFO - 2015-11-28 22:21:58,584 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:21:58 INFO - 2015-11-28 22:21:58,584 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;105;115;113;111;123;110;111;110;110 22:21:58 INFO - 2015-11-28 22:21:58,584 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;127;153;164;128;151;150;129;167;129 22:21:58 INFO - 2015-11-28 22:21:58,584 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;163;161;163;163;162;162;162;173;162 22:21:58 INFO - 2015-11-28 22:21:58,585 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;72;73;78;71;138;73;71;71 22:21:58 INFO - 2015-11-28 22:21:58,585 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;94;136;93;93;93;135;94;94;142 22:21:58 INFO - 2015-11-28 22:21:58,585 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;109;109;111;110;110;110 22:21:58 INFO - 2015-11-28 22:21:58,585 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;150;147;146;148;147;146;147;147;146;146 22:21:58 INFO - 2015-11-28 22:21:58,585 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;95;98;97;95;96;95 22:21:58 INFO - 2015-11-28 22:21:58,585 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;63;63;63;64;62;63;62;70;62 22:21:58 INFO - 2015-11-28 22:21:58,585 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;72;71;72;71;71;72;71;71;70;79 22:21:58 INFO - 2015-11-28 22:21:58,585 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;86;85;85;86;86;86;86;86;95 22:21:58 INFO - 2015-11-28 22:21:58,586 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;116;130;119;117;126;118;131;115;131 22:21:58 INFO - 2015-11-28 22:21:58,586 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;160;152;163;152;143;142;151;151;163 22:21:58 INFO - 2015-11-28 22:21:58,586 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;67;70;67;69;71;67;69;69;67 22:21:58 INFO - 2015-11-28 22:21:58,586 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:21:58 INFO - 2015-11-28 22:21:58,586 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:21:58 INFO - 2015-11-28 22:21:58,586 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,736 22:21:58 INFO - 2015-11-28 22:21:58,586 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:21:58 INFO - 2015-11-28 22:21:58,587 DEBUG : BROWSER_OUTPUT: __startTimestamp1448778118582__endTimestamp 22:21:58 INFO - 2015-11-28 22:21:58,587 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-28 22:21:58,594 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:21:58 INFO - 2015-11-28 22:21:58,594 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:21:58 INFO - 2015-11-28 22:21:58,594 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-28 22:21:58,594 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.90 Median:111.00 stddev:4.65 (4.2%) stddev-sans-first:4.92 22:21:58 INFO - 2015-11-28 22:21:58,594 DEBUG : BROWSER_OUTPUT: Values: 111.0 105.0 115.0 113.0 111.0 123.0 110.0 111.0 110.0 110.0 22:21:58 INFO - 2015-11-28 22:21:58,595 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-28 22:21:58,595 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:145.40 Median:152.00 stddev:15.69 (10.3%) stddev-sans-first:16.16 22:21:58 INFO - 2015-11-28 22:21:58,595 DEBUG : BROWSER_OUTPUT: Values: 156.0 127.0 153.0 164.0 128.0 151.0 150.0 129.0 167.0 129.0 22:21:58 INFO - 2015-11-28 22:21:58,595 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-28 22:21:58,595 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.10 Median:162.50 stddev:3.60 (2.2%) stddev-sans-first:3.64 22:21:58 INFO - 2015-11-28 22:21:58,595 DEBUG : BROWSER_OUTPUT: Values: 160.0 163.0 161.0 163.0 163.0 162.0 162.0 162.0 173.0 162.0 22:21:58 INFO - 2015-11-28 22:21:58,595 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-28 22:21:58,595 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.10 Median:72.00 stddev:20.80 (28.9%) stddev-sans-first:21.90 22:21:58 INFO - 2015-11-28 22:21:58,595 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 72.0 73.0 78.0 71.0 138.0 73.0 71.0 71.0 22:21:58 INFO - 2015-11-28 22:21:58,595 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-28 22:21:58,595 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.70 Median:93.00 stddev:21.45 (23.1%) stddev-sans-first:22.17 22:21:58 INFO - 2015-11-28 22:21:58,595 DEBUG : BROWSER_OUTPUT: Values: 93.0 94.0 136.0 93.0 93.0 93.0 135.0 94.0 94.0 142.0 22:21:58 INFO - 2015-11-28 22:21:58,595 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-28 22:21:58,595 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 22:21:58 INFO - 2015-11-28 22:21:58,596 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 109.0 109.0 111.0 110.0 110.0 110.0 22:21:58 INFO - 2015-11-28 22:21:58,596 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-28 22:21:58,596 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.25 (0.8%) stddev-sans-first:0.71 22:21:58 INFO - 2015-11-28 22:21:58,596 DEBUG : BROWSER_OUTPUT: Values: 150.0 147.0 146.0 148.0 147.0 146.0 147.0 147.0 146.0 146.0 22:21:58 INFO - 2015-11-28 22:21:58,596 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-28 22:21:58,596 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.03 (1.1%) stddev-sans-first:1.05 22:21:58 INFO - 2015-11-28 22:21:58,596 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 95.0 98.0 97.0 95.0 96.0 95.0 22:21:58 INFO - 2015-11-28 22:21:58,596 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-28 22:21:58,596 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.00 stddev:2.41 (3.8%) stddev-sans-first:2.51 22:21:58 INFO - 2015-11-28 22:21:58,596 DEBUG : BROWSER_OUTPUT: Values: 62.0 63.0 63.0 63.0 64.0 62.0 63.0 62.0 70.0 62.0 22:21:58 INFO - 2015-11-28 22:21:58,596 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-28 22:21:58,596 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:71.50 stddev:2.54 (3.6%) stddev-sans-first:2.69 22:21:58 INFO - 2015-11-28 22:21:58,596 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 72.0 71.0 71.0 72.0 71.0 71.0 70.0 79.0 22:21:58 INFO - 2015-11-28 22:21:58,596 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-28 22:21:58,596 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.00 stddev:3.06 (3.6%) stddev-sans-first:3.11 22:21:58 INFO - 2015-11-28 22:21:58,597 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 85.0 85.0 86.0 86.0 86.0 86.0 86.0 95.0 22:21:58 INFO - 2015-11-28 22:21:58,597 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-28 22:21:58,597 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:126.00 stddev:6.54 (5.2%) stddev-sans-first:6.84 22:21:58 INFO - 2015-11-28 22:21:58,597 DEBUG : BROWSER_OUTPUT: Values: 126.0 116.0 130.0 119.0 117.0 126.0 118.0 131.0 115.0 131.0 22:21:58 INFO - 2015-11-28 22:21:58,597 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-28 22:21:58,597 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.00 Median:152.00 stddev:7.96 (5.2%) stddev-sans-first:7.75 22:21:58 INFO - 2015-11-28 22:21:58,597 DEBUG : BROWSER_OUTPUT: Values: 143.0 160.0 152.0 163.0 152.0 143.0 142.0 151.0 151.0 163.0 22:21:58 INFO - 2015-11-28 22:21:58,597 DEBUG : BROWSER_OUTPUT: 22:21:58 INFO - 2015-11-28 22:21:58,597 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.81 (2.6%) stddev-sans-first:1.51 22:21:58 INFO - 2015-11-28 22:21:58,597 DEBUG : BROWSER_OUTPUT: Values: 72.0 67.0 70.0 67.0 69.0 71.0 67.0 69.0 69.0 67.0 22:21:58 INFO - 2015-11-28 22:21:58,597 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:21:58 INFO - 2015-11-28 22:21:58,597 DEBUG : BROWSER_OUTPUT: 22:21:59 INFO - 2015-11-28 22:21:59,433 INFO : Browser exited with error code: 0 22:21:59 INFO - 2015-11-28 22:21:59,484 INFO : Completed test kraken (00:00:59) 22:21:59 INFO - 2015-11-28 22:21:59,484 INFO : Starting test v8_7 22:21:59 INFO - 2015-11-28 22:21:59,484 DEBUG : operating with platform_type : linux_ 22:21:59 INFO - 2015-11-28 22:21:59,484 INFO : Initialising browser for v8_7 test... 22:21:59 INFO - 2015-11-28 22:21:59,490 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNGEV0N/profile http://localhost:49593/getInfo.html 22:22:03 INFO - 2015-11-28 22:22:03,375 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:22:03 INFO - 2015-11-28 22:22:03,375 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:22:03 INFO - 2015-11-28 22:22:03,375 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:22:03 INFO - 2015-11-28 22:22:03,375 DEBUG : BROWSER_OUTPUT: __metrics 22:22:04 INFO - 2015-11-28 22:22:04,309 INFO : Browser initialized. 22:22:04 INFO - 2015-11-28 22:22:04,310 INFO : Running cycle 1/1 for v8_7 test... 22:22:04 INFO - 2015-11-28 22:22:04,310 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNGEV0N/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:22:16 INFO - 2015-11-28 22:22:16,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 138694656 22:22:16 INFO - 2015-11-28 22:22:16,091 DEBUG : BROWSER_OUTPUT: 22:22:37 INFO - 2015-11-28 22:22:37,479 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49593/tests/v8_7/run.html (next: http://localhost:49593/tests/v8_7/run.html) 22:22:37 INFO - 2015-11-28 22:22:37,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 136904704 22:22:37 INFO - 2015-11-28 22:22:37,737 DEBUG : BROWSER_OUTPUT: 22:22:37 INFO - 2015-11-28 22:22:37,737 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:22:37 INFO - 2015-11-28 22:22:37,738 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:22:37 INFO - 2015-11-28 22:22:37,738 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:22:37 INFO - 2015-11-28 22:22:37,738 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:22:37 INFO - 2015-11-28 22:22:37,738 DEBUG : BROWSER_OUTPUT: |0;Richards;167.61649346295675 22:22:37 INFO - 2015-11-28 22:22:37,738 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.14675446848543 22:22:37 INFO - 2015-11-28 22:22:37,739 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.7254735651682 22:22:37 INFO - 2015-11-28 22:22:37,739 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 22:22:37 INFO - 2015-11-28 22:22:37,739 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1067.2358591248667 22:22:37 INFO - 2015-11-28 22:22:37,739 DEBUG : BROWSER_OUTPUT: |5;Earley;736.9196757553427 22:22:37 INFO - 2015-11-28 22:22:37,739 DEBUG : BROWSER_OUTPUT: |6;Boyer;12072.289156626506 22:22:37 INFO - 2015-11-28 22:22:37,740 DEBUG : BROWSER_OUTPUT: |7;RegExp;25000 22:22:37 INFO - 2015-11-28 22:22:37,740 DEBUG : BROWSER_OUTPUT: |8;Splay;659.016393442623 22:22:37 INFO - 2015-11-28 22:22:37,740 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 22:22:37 INFO - 2015-11-28 22:22:37,740 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:22:37 INFO - 2015-11-28 22:22:37,740 DEBUG : BROWSER_OUTPUT: __startTimestamp1448778157731__endTimestamp 22:22:37 INFO - 2015-11-28 22:22:37,741 DEBUG : BROWSER_OUTPUT: 22:22:37 INFO - 2015-11-28 22:22:37,741 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:22:37 INFO - 2015-11-28 22:22:37,741 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:22:37 INFO - 2015-11-28 22:22:37,741 DEBUG : BROWSER_OUTPUT: 22:22:37 INFO - 2015-11-28 22:22:37,741 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.62 Median:167.62 stddev:0.00 (0.0%) 22:22:37 INFO - 2015-11-28 22:22:37,741 DEBUG : BROWSER_OUTPUT: Values: 167.6 22:22:37 INFO - 2015-11-28 22:22:37,742 DEBUG : BROWSER_OUTPUT: 22:22:37 INFO - 2015-11-28 22:22:37,742 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.15 Median:188.15 stddev:0.00 (0.0%) 22:22:37 INFO - 2015-11-28 22:22:37,742 DEBUG : BROWSER_OUTPUT: Values: 188.1 22:22:37 INFO - 2015-11-28 22:22:37,742 DEBUG : BROWSER_OUTPUT: 22:22:37 INFO - 2015-11-28 22:22:37,742 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.73 Median:282.73 stddev:0.00 (0.0%) 22:22:37 INFO - 2015-11-28 22:22:37,743 DEBUG : BROWSER_OUTPUT: Values: 282.7 22:22:37 INFO - 2015-11-28 22:22:37,743 DEBUG : BROWSER_OUTPUT: 22:22:37 INFO - 2015-11-28 22:22:37,743 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 22:22:37 INFO - 2015-11-28 22:22:37,743 DEBUG : BROWSER_OUTPUT: Values: 5191.7 22:22:37 INFO - 2015-11-28 22:22:37,743 DEBUG : BROWSER_OUTPUT: 22:22:37 INFO - 2015-11-28 22:22:37,744 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1067.24 Median:1067.24 stddev:0.00 (0.0%) 22:22:37 INFO - 2015-11-28 22:22:37,744 DEBUG : BROWSER_OUTPUT: Values: 1067.2 22:22:37 INFO - 2015-11-28 22:22:37,744 DEBUG : BROWSER_OUTPUT: 22:22:37 INFO - 2015-11-28 22:22:37,744 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:736.92 Median:736.92 stddev:0.00 (0.0%) 22:22:37 INFO - 2015-11-28 22:22:37,744 DEBUG : BROWSER_OUTPUT: Values: 736.9 22:22:37 INFO - 2015-11-28 22:22:37,745 DEBUG : BROWSER_OUTPUT: 22:22:37 INFO - 2015-11-28 22:22:37,746 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12072.29 Median:12072.29 stddev:0.00 (0.0%) 22:22:37 INFO - 2015-11-28 22:22:37,746 DEBUG : BROWSER_OUTPUT: Values: 12072.3 22:22:37 INFO - 2015-11-28 22:22:37,746 DEBUG : BROWSER_OUTPUT: 22:22:37 INFO - 2015-11-28 22:22:37,746 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25000.00 Median:25000.00 stddev:0.00 (0.0%) 22:22:37 INFO - 2015-11-28 22:22:37,746 DEBUG : BROWSER_OUTPUT: Values: 25000.0 22:22:37 INFO - 2015-11-28 22:22:37,747 DEBUG : BROWSER_OUTPUT: 22:22:37 INFO - 2015-11-28 22:22:37,747 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:659.02 Median:659.02 stddev:0.00 (0.0%) 22:22:37 INFO - 2015-11-28 22:22:37,747 DEBUG : BROWSER_OUTPUT: Values: 659.0 22:22:37 INFO - 2015-11-28 22:22:37,747 DEBUG : BROWSER_OUTPUT: 22:22:37 INFO - 2015-11-28 22:22:37,747 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 22:22:37 INFO - 2015-11-28 22:22:37,748 DEBUG : BROWSER_OUTPUT: Values: 4830.9 22:22:37 INFO - 2015-11-28 22:22:37,748 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:22:37 INFO - 2015-11-28 22:22:37,748 DEBUG : BROWSER_OUTPUT: 22:22:38 INFO - 2015-11-28 22:22:38,553 INFO : Browser exited with error code: 0 22:22:38 INFO - 2015-11-28 22:22:38,568 INFO : Completed test v8_7 (00:00:39) 22:22:38 INFO - 2015-11-28 22:22:38,766 INFO : Completed test suite (00:20:08) 22:22:38 INFO - 2015-11-28 22:22:38,766 DEBUG : Working with test: dromaeo_css 22:22:38 INFO - 2015-11-28 22:22:38,766 DEBUG : Generating results file: dromaeo_css 22:22:38 INFO - 2015-11-28 22:22:38,767 DEBUG : Working with test: kraken 22:22:38 INFO - 2015-11-28 22:22:38,768 DEBUG : Generating results file: kraken 22:22:38 INFO - 2015-11-28 22:22:38,768 INFO : javascript benchmark 22:22:38 INFO - 2015-11-28 22:22:38,768 DEBUG : Working with test: v8_7 22:22:38 INFO - 2015-11-28 22:22:38,768 DEBUG : Generating results file: v8_7 22:22:38 INFO - 2015-11-28 22:22:38,769 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:22:38 INFO - 2015-11-28 22:22:38,830 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 22:22:38 INFO - 2015-11-28 22:22:38,831 DEBUG : process_Request line: dromaeo_css 7078.19 graph.html#tests=[[72,64,43]] 22:22:38 INFO - 2015-11-28 22:22:38,831 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:22:38 INFO - 2015-11-28 22:22:38,872 DEBUG : process_Request line: kraken 1524.40 graph.html#tests=[[232,64,43]] 22:22:38 INFO - 2015-11-28 22:22:38,872 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:22:38 INFO - 2015-11-28 22:22:38,913 DEBUG : process_Request line: v8_7 21138.27 graph.html#tests=[[230,64,43]] 22:22:38 INFO - 2015-11-28 22:22:38,914 INFO : javascript benchmark 22:22:38 INFO - 2015-11-28 22:22:38,918 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3252.983735081325, 3293.5553700250457, 3316.452785290427, 3339.5825521809775, 3345.9498107528393, 5372.247885296052, 5516.448355164482, 5520.702634880805, 5523.502884740373, 5530.751116199771, 5421.593380496459, 5486.012517746814, 5607.467290607386, 5709.600327977043, 5716.028275193216, 5019.272205530205, 5081.339425874631, 5141.948580514184, 5164.941187056645, 5166.741662916858, 5072.543471087602, 5075.720835354054, 5114.641975061747, 5136.126858434057, 5172.198309262051, 4965.404151501807, 5025.3718285214345, 5084.059449001909, 5092.821751238707, 5112.590992720592, 5051.444341122474, 5077.111505486562, 5085.5931525478245, 5088.23676448532, 5106.5659418949435, 5072.442031376546, 5085.669431486942, 5090.261912022736, 5094.235864620299, 5099.260607211971, 5178.97410512945, 5237.0, 5323.680579165262, 5372.946270537283, 5408.432114627947, 5980.43185897339, 6070.726817293233, 6074.787382441637, 6079.240094988127, 6079.544034197409, 6066.908996365058, 6074.301455332605, 6074.8785024299705, 6088.512918966472, 6090.817275481699, 5510.173473978895, 5523.613347065707, 5575.637583557056, 5583.4974852263085, 5603.80386686464, 6073.0283154695035, 6085.513158947274, 6094.146819445281, 6112.266528016667, 6119.418655227746, 5763.510101641407, 5884.146798714162, 5888.941110588839, 5890.9410905891245, 5894.410558944071, 5946.524278057832, 5994.460498555151, 6071.453569178707, 6109.2528441424865, 6132.17215675878, 5961.880762384728, 5969.492593129546, 6012.248468941382, 6016.578839481194, 6020.668863212478, 5760.0, 5863.736131874076, 6025.0661147522205, 6025.698715064317, 6037.788677396358, 4539.387182730356, 4584.060267645124, 4585.358049873021, 4619.168549661026, 4632.02727427244, 4113.753174809521, 4120.093579412524, 4123.711340206157, 4129.2773764591075, 4162.021924847659, 5655.971720141455, 5744.253247077937, 5768.394318596487, 5782.132680098019, 5784.942150578525, 5908.350081491032, 5975.25309336333, 5976.760929562855, 6010.639361638316, 6049.8487537811025, 5694.174344720075, 5698.914516282176, 5701.287339082614, 5718.542516598662, 5732.598718089694, 5057.519535644108, 5146.022255771391, 5147.819826306136, 5152.3044389007755, 5210.140326846028, 6055.061465472859, 6131.315499378962, 6132.324915438597, 6142.590862071594, 6145.231846019247, 5979.1928089707335, 6048.213732214784, 6052.90920636182, 6059.3334733178435, 6066.757329706762, 6006.669633170218, 6076.72654730547, 6210.689465526796, 6211.534134939988, 6220.222472190976, 5816.331121921034, 5836.766529338779, 5843.181954526284, 5922.466977971831, 5968.164456976114, 5946.940530594812, 5972.581919265784, 6009.909851352146, 6019.969900150471, 6021.066734656135, 5572.526335261548, 5878.147668588116, 5883.0293001654245, 5891.911621325769, 5897.292324921037, 5785.074388097884, 5795.797147099831, 5859.765609375577, 5883.235179426647, 5930.140129681258, 5744.080947048452, 5783.219265399117, 5786.884262314646, 5793.710314484343, 5805.82582522525, 5731.197632331394, 5843.883122337615, 5868.765249389977, 5960.4635582797755, 5963.940360596512, 5670.914936276042, 5767.307923049261, 5774.249347584787, 5777.191193233035, 5819.098039803837], "unit": "ms", "name": "dojo.html", "value": 5515.86354979589}, {"lowerIsBetter": false, "replicates": [550.1994597860114, 610.2554883042687, 612.4855121697773, 621.0994058615008, 628.7924984755032, 39328.0, 40282.59717402825, 40311.79844100779, 40339.19321613566, 40395.394069088914, 42899.0, 42987.140257194835, 43401.782991085, 43533.782331088376, 43560.12879742411, 8807.515586642716, 8999.955000224989, 9001.549922503882, 9007.729768106967, 9024.413413128159, 8751.16863897932, 8839.07189745074, 8843.425177363482, 8854.07032261613, 8857.822843543157, 8786.64853405863, 8850.380473366868, 8854.601542930584, 8863.290936725047, 8863.601137948775, 8795.296376289882, 8858.557072146366, 8881.866771998426, 8897.421667591585, 8915.821683566357, 8740.8688869667, 8775.078616745213, 8850.867236991451, 8869.157430044135, 8873.11268873114, 39993.60006399928, 40472.0, 40606.39090413646, 40655.593444065475, 40693.59306406957, 3282.4091663500562, 3347.2301370684636, 3648.8175591220597, 3721.3301605710963, 4001.4598029265967, 29832.0, 29897.0, 30253.0, 30253.24366890823, 30659.0, 3821.9617803821884, 3833.5974722654, 3877.8448862045484, 3914.921701565981, 3948.4866967294356, 244950.0, 247356.0, 248829.0, 249416.0, 252141.0, 55945.16082258769, 56649.43350566524, 56740.0, 56891.431085689444, 57023.58275963777, 68789.0, 70523.64738176276, 70588.64705676438, 70649.0, 70690.64654676693, 14080.366383512766, 14111.647208819657, 14120.71758564823, 14144.504942326968, 14268.14391136535, 11222.887771122347, 11259.605913792979, 11298.435078246055, 11311.886881131248, 11360.48877800501, 19663.60672786565, 19971.700424493643, 20030.298939537046, 20060.89969550143, 20072.197112115642, 7749.418793590503, 7868.763937081897, 7928.960355198187, 7961.243681850215, 8047.171696981764, 985.6205360935948, 997.6907158780801, 999.5302207962392, 1019.2304809868501, 1045.2213101239472, 28163.0, 28361.43277134487, 28631.14106576806, 28693.413323334582, 28758.568621470695, 1069.2889228662852, 1086.3047649504324, 1119.8880111988735, 1145.3929417408788, 1203.0676225924803, 14603.196824174773, 14696.619777451246, 15003.0, 15060.623484412978, 15228.46700365504, 301845.0, 302245.0, 303720.0, 305413.0, 305812.0, 51371.22943155855, 51635.741821290656, 51885.22172167421, 51995.48004519982, 52050.21924671133, 1335.105479328852, 1351.8512963574196, 1355.7017456159826, 1362.7615167345675, 1469.4489566412594, 27193.72806271991, 28263.858680706464, 28486.57270140908, 29615.703842961295, 30915.536266956464, 47939.520604793506, 48679.0, 48704.26943595778, 48742.0, 48797.75601121972, 264504.0, 266364.0, 266770.0, 266785.0, 267050.0, 31892.36215275728, 32132.83933580317, 32362.190945226557, 32500.187495312806, 32561.674383255864, 38233.0, 38723.612763872, 38786.41820372753, 39253.2149357017, 39953.20093598054, 33056.50415243725, 34987.47518787271, 35817.81981085117, 36337.0, 36477.81761091178, 35763.284734305686, 35945.820270898475, 36047.0, 36055.0, 36083.0, 35464.0, 35909.820450898624, 36020.0, 36085.45871811977, 36302.455463168604, 30579.847100764353, 32061.03816885497, 32664.34671306513, 32708.672913271515, 32786.67213327836, 25073.0, 25242.49515009653, 25336.927223719587, 25601.74398256068, 25715.228543143734], "unit": "ms", "name": "ext.html", "value": 18543.19260459751}, {"lowerIsBetter": false, "replicates": [355.87544359474185, 356.64157521690714, 357.80486714009544, 358.1511816993725, 360.55831606282305, 16480.67038659226, 16641.750373744402, 17130.31478740849, 17385.82614173858, 18049.81950180501, 11253.0, 11285.435728213577, 11320.943395283033, 12275.017998560115, 16030.118343491104, 4997.075541024922, 5011.974940125294, 5090.236464530331, 5108.667936584129, 5173.379194496647, 5088.287639730423, 5113.769880355374, 5125.820596279131, 5128.230765385203, 5129.820456284031, 4989.775460104286, 5109.974450127745, 5122.282880396748, 5211.557017653485, 5330.813421530247, 5266.473352664722, 5269.499397557264, 5274.472552744734, 5304.496072873071, 5345.946540534604, 5118.667286626394, 5266.60500462463, 5269.6311258211945, 5306.204069389584, 5311.150215965466, 12898.87101128986, 13129.868701313055, 16339.0, 20341.593168136555, 20543.486412839648, 2070.285751415759, 2090.1325949730845, 2090.2266161520333, 2117.6611742121186, 2201.152556265833, 9573.712788616353, 9980.950095249478, 10962.671119866416, 11164.883511648852, 13559.322033898266, 1730.3943619732993, 1767.4079183473552, 1836.8530517558563, 1898.250191174492, 2027.3715148304072, 60082.0, 64014.039789403665, 64646.0, 64884.675576622285, 65637.3436265636, 10441.112505437122, 10476.371417714961, 10482.318649287772, 10513.421761803174, 10603.946980265204, 13578.796318055238, 13645.727085458235, 13675.0, 13723.931380343234, 13762.24307663088, 7568.675481790665, 7643.885341719767, 7654.464187506933, 7687.654055567513, 7699.037620297463, 7391.223921488274, 7410.296021877913, 7414.369778568775, 7451.0, 7472.589007604525, 4468.843590474383, 4494.325851122292, 4513.345564893072, 4538.205813982539, 4565.977170114128, 1810.8641851861164, 1847.5658419792605, 1849.5930895203303, 1858.851291896645, 1869.6634605770819, 397.01738197959816, 425.15394365213, 425.90842968761245, 439.58678841888525, 466.8272739086492, 10782.67651970442, 11284.830727539094, 11443.0, 11482.598109066143, 11485.138614603939, 829.4815740162398, 920.2408013388981, 943.165298710646, 970.4371464550544, 1016.9237307201842, 9371.390859594105, 9625.0, 10073.345232559861, 10074.59701611942, 10079.193664506822, 529467.0, 531314.0, 534185.0, 542122.0, 548547.0, 75701.0, 76279.0, 78285.0, 78332.60833695909, 79724.0, 1169.4094482286391, 1185.7154282972197, 1190.398848581461, 1193.3555879824971, 1193.4689063366718, 15264.694706106038, 15432.84567154314, 15541.844581554493, 15594.376224950875, 15686.843131568538, 34320.313593727486, 34400.311993760486, 35198.824005879804, 35526.82236588904, 36013.0996725084, 46633.3005004932, 47546.762266188445, 47554.52445475501, 47733.76133119312, 50330.2450463236, 9624.085711857362, 9678.854817177607, 9768.0, 9805.509724513604, 9865.802683946138, 13736.313184340543, 16887.831121689116, 17028.0, 17564.73652895182, 17664.823351766318, 9403.811923761623, 9640.699206803205, 9733.805323893625, 14506.85493145055, 14588.270586470422, 9564.76088097803, 10213.540390682288, 10222.233332499944, 10393.0, 10480.790384192425, 10797.946010269898, 10822.458877056273, 11004.779904401707, 11028.558857645605, 11057.447127643425, 13435.664108397368, 14105.435782568582, 15150.090994540364, 15177.772333414787, 15830.208489575705, 16139.75790363169, 16282.918585406996, 16566.83433165653, 16676.08281544527, 16747.581310467336], "unit": "ms", "name": "jquery.html", "value": 8478.164199071181}, {"lowerIsBetter": false, "replicates": [1396.1204441202044, 1442.9855701442987, 1586.2068965517242, 1638.3528506240043, 1746.414950991417, 7266.491345605809, 7315.195328513859, 7411.332980031796, 7864.8427031459405, 7886.723964661245, 7645.15903250642, 7825.452218344718, 7925.920740792591, 7931.087924888625, 7955.681772729098, 2277.954440911177, 2294.0365046680436, 2312.676225328447, 2314.4329639238326, 2314.5602335556273, 2280.783325584067, 2319.9536009279805, 2331.825113116515, 2345.1909091363455, 2353.5528249632516, 2289.748127705951, 2289.9656505152434, 2334.031376978552, 2336.0655737704883, 2338.924094916332, 2253.86476811391, 2258.5369999150134, 2277.373722226401, 2277.5558766040544, 2280.8745518996448, 2309.3418375762826, 2314.849534780251, 2316.7683231676865, 2330.9300720978226, 2333.696619439479, 7851.45039847211, 7897.131315555284, 7955.96022019892, 7978.960105199495, 7999.0, 4713.245880659112, 4759.262314341283, 4803.3995750531185, 4806.639502037361, 4824.372831531913, 3043.5434684797237, 3050.0544831102206, 3098.148009297439, 3109.207152176203, 3139.780215384924, 1008.9949550252276, 1018.9337693049928, 1028.4703377760459, 1042.0413219837767, 1900.3633782682818, 10452.477376131163, 10494.265401421904, 10589.417582032986, 10591.099756520627, 10614.363138211655, 4168.187203495289, 4214.662826973835, 4264.552222016706, 4303.33298338758, 4313.352997050405, 8382.0, 8387.203215694499, 8395.328373730086, 8408.663653453794, 8412.831743365221, 4726.621870250372, 4728.645351598575, 4732.148213321635, 4739.218029025241, 4789.090072886141, 4328.523862375137, 4372.191144638252, 4394.604485596312, 4402.405675233803, 4414.58061484165, 3594.2092739597247, 3607.206414588786, 3630.09247688078, 3638.1268495561403, 3670.3026424979703, 1122.7361570031037, 1123.6179698902413, 1124.224285243196, 1124.9268797528134, 1132.4960392625203, 1052.2371280821496, 1067.386252904583, 1069.1072954083272, 1258.5154715434624, 1368.0423703407655, 7546.962265188639, 7608.80977975555, 7620.771376858703, 7624.390048796083, 7627.046619172604, 482.2862163997304, 488.1213815132747, 489.9632527560447, 491.42503271172814, 494.88865005373503, 5889.0, 5919.1713160157615, 5983.072623743326, 5984.491318237911, 6002.339742628307, 9106.0, 9510.429374237568, 9510.90489095114, 9544.236461083097, 9671.90328096724, 9401.623935042522, 9425.622975081056, 9431.76420589477, 9432.292578056673, 9530.0, 7351.485396022227, 7414.703411863573, 7466.813329666693, 7485.101787785392, 7492.587907665131, 7116.679749411185, 7180.964095179491, 7201.963990180016, 7230.168530619047, 7244.239354867663, 8386.161383861565, 8390.832183356177, 8490.91509084926, 8498.490090594583, 8575.3997220194, 8575.0, 8698.173673501007, 8711.25954293892, 8745.781355466164, 8759.956200218958, 6453.9354606453335, 6742.292059333896, 6861.519693621399, 6940.861182776215, 6964.199117101395, 7371.852562948604, 7378.040854688856, 7399.704011839466, 7406.555606663617, 7465.7013719450615, 7135.286471352823, 7185.425165986813, 7190.604516751629, 7301.634918254173, 7437.888431673421, 6961.582305061713, 6969.721211151497, 7043.506954513135, 7066.434685225273, 7090.113735783028, 7173.641317933978, 7295.306945840137, 7354.558726476428, 7374.631268436664, 7380.298871607403, 6661.933380666325, 6695.799126026227, 6703.229128650268, 6751.257361690308, 6797.93202067973, 6505.674716264073, 6604.603723776589, 6678.933210667831, 6899.827504312231, 6903.413209877217], "unit": "ms", "name": "mootools.html", "value": 4444.893647382744}, {"lowerIsBetter": false, "replicates": [336.18642884220185, 338.9135770378553, 346.35059263880214, 348.1192582765604, 348.5375819832879, 6150.292716337623, 6290.4653104486115, 6317.084022816694, 6332.050192471132, 6379.0, 6123.785667501638, 6239.688015599225, 6258.123862659231, 6271.968640156792, 6273.3412991635905, 4806.7115973041555, 4809.110314591794, 4818.566329030386, 4821.228603423436, 4826.276058591205, 4818.34952281441, 4820.927686084711, 4827.975860120694, 4828.299896515004, 4833.734144622044, 4694.953050469503, 4777.0, 4793.9520604794025, 4794.472608013116, 4803.423589169304, 4765.523447655241, 4772.284157376386, 4780.928286075712, 4784.330193772875, 4789.2816077588295, 4195.307774217251, 4210.978945105286, 4212.115455754295, 4213.789310534492, 4236.4704411948505, 5932.644041357532, 5932.911006334908, 5943.673097979609, 5944.10838374243, 5944.286685597756, 5485.780568777244, 5607.4112218217315, 5628.296462942132, 5640.505266104486, 5643.915341269884, 6621.106150669694, 6633.701483433257, 6640.8671826563195, 6658.334166583351, 6664.366885145903, 4679.15775160471, 4693.78877950493, 4701.529847015271, 4701.7414042227665, 4708.152532544141, 6793.694283757193, 6937.132858392701, 6947.3747362737595, 6985.511014228955, 7024.508284420092, 4670.69640473375, 4696.483386827446, 4701.1537923174155, 4703.553162449562, 4725.598324142417, 4746.28805679144, 4751.928721069186, 4753.524647535219, 4755.310479980383, 4776.95223047772, 5508.118701007819, 5517.2551705520045, 5547.5007249346945, 5551.666899986014, 5556.388797232301, 6582.275949645536, 6735.360140786617, 6736.854734695114, 6746.797596072126, 6750.459963202932, 1637.3859802574034, 1676.1702957036346, 1683.166832417961, 1684.0485125903824, 1686.6289416328389, 1107.534835369147, 1121.4224674292745, 1126.059740116995, 1133.8525991621202, 1135.8296255561568, 6417.7753778617525, 6420.0, 6420.945297504753, 6434.678266086677, 6443.420092191725, 6844.315568443216, 6852.109225800614, 6866.416354609814, 6870.416014638712, 6871.175458944958, 6373.553851230462, 6373.872522549523, 6395.392437718409, 6438.742450301936, 6442.130312407859, 3801.0497375656087, 3816.9618303816605, 3823.923521529554, 3823.9808800955816, 3826.3877779555137, 7200.315969982948, 7318.3047610476915, 7324.535092981425, 7328.560286382834, 7336.559806411632, 7051.92948070523, 7141.285871412817, 7168.960500727365, 7194.64026798658, 7206.171290301682, 7226.819329516699, 7253.093363329584, 7276.599787011659, 7285.198628150899, 7325.340719335285, 6928.757493487704, 6933.37599616037, 6943.444524438134, 6970.825729356604, 6977.79066628002, 6712.765053223114, 6839.794806155824, 6845.897311540231, 6885.862282754217, 6901.89647155283, 7267.236940121423, 7274.527155734861, 7277.636118193963, 7279.708811647687, 7290.234525374759, 4605.585497305125, 4633.606143477842, 4643.233866412004, 4648.325992731103, 4650.534946505322, 6627.5360724750735, 6785.219699734396, 6811.557248778813, 6949.339812717783, 6963.40811031068, 6584.111144995556, 6682.0, 6710.496712746662, 6746.359095885883, 6785.558938668971, 6745.055692202997, 6789.728410863708, 6796.150481189851, 6796.558223715443, 6797.116374871235, 6412.0, 6607.471402287902, 6624.470042396693, 6626.83432914181, 6654.201495820533, 6766.492513061638, 6770.796876093725, 6774.593524388552, 6789.15135608049, 6797.66011699423, 6626.469882409492, 6629.370209830058, 6632.369924857131, 6635.933640663531, 6659.500537459613], "unit": "ms", "name": "prototype.html", "value": 5048.151338633648}, {"lowerIsBetter": false, "replicates": [813.4875028731898, 814.7107776739256, 849.9320054395649, 866.1987661413191, 866.5104216117888, 12803.359832008397, 12904.612861614154, 12983.156094853828, 13468.25924574148, 13534.052616316862, 13440.865591344083, 13455.192688438701, 13455.663608409795, 13509.256990865499, 13587.320633968287, 677.3226773226774, 684.03209458616, 815.9102498725135, 818.30444122496, 829.8838162657232, 826.7023871406288, 826.983460330793, 834.328365665642, 834.6536187482218, 834.6869923778584, 875.1467319363601, 876.3514998900799, 877.8814859993882, 880.2385936165235, 881.4887365328126, 866.8353012927555, 867.8307729992654, 868.7263511993701, 872.1540106097076, 872.2019352292644, 637.3085202555233, 637.9553431259814, 638.4286063972719, 639.6961443314435, 640.4972096903955, 13616.0, 13617.591472255848, 13703.314834258248, 13735.175889446666, 13738.519151829738, 11577.189596728233, 11708.707282317924, 11781.293122412682, 11832.70418239551, 11869.228500147463, 10212.642557510451, 10256.128229100535, 10290.588376464932, 10377.429241391721, 10426.0, 3568.4468907319406, 3597.172650290448, 3611.7652352596997, 3612.259486805199, 3751.4747935289083, 49274.50725492771, 49797.75101124471, 49822.750886245696, 49857.50142498565, 49961.75019124917, 10153.898461015444, 10252.692419227435, 10327.690169294932, 10341.896581034243, 10620.150387968944, 19063.90468047651, 19073.332433364765, 19094.809051909582, 19123.80876191248, 19127.61744765097, 7849.529028258323, 7978.441509094308, 7993.480423772437, 8009.479383840032, 8185.058718247358, 4293.677974151951, 4341.044970106572, 4408.735475871458, 4441.178381999341, 4488.079943611552, 3060.816351018946, 3072.1858707442548, 3091.458994675923, 3096.34976654905, 3103.0380582019193, 536.5707434052742, 559.0440347006664, 566.2073097663305, 566.334556895646, 567.1974156568492, 545.1005840363352, 597.8924786715294, 659.2226541914855, 679.6533767778468, 698.078536332047, 8401.201885820838, 8443.915560844436, 8549.829003420022, 8594.546949124075, 8685.218330350172, 702.6381413572014, 709.393468584353, 711.2226754523593, 721.3579913876654, 730.5288089182554, 4032.9395059074136, 4209.989602495379, 4283.850065247701, 4346.913061738747, 4477.686561940698, 60860.39139608547, 61412.078818817754, 61890.69054654788, 62232.68883655643, 62268.68865655734, 53614.7319263409, 53702.731486342316, 53790.19314710282, 53893.461065388845, 54342.18486722702, 49846.0, 50010.0, 50600.0, 50689.493105068475, 51545.48454515407, 8416.3266938646, 8537.573121344032, 8576.614052367533, 8675.219230269306, 8916.687915922912, 36800.26399472049, 36994.44508332323, 37202.0, 37612.811935940146, 37639.0, 43570.0, 44042.33936491019, 48842.26736599025, 48989.0, 49099.75450122727, 10990.615328463466, 11119.27724697892, 11348.602798901999, 11349.773004540028, 11662.53349865996, 12364.690882728004, 12697.55558555446, 12717.682057948625, 13095.214287142802, 13136.080474366703, 11852.70368240801, 11853.143043904538, 11962.58130965412, 11963.527280287766, 11981.820272696092, 11719.88280117188, 11988.76022479528, 12075.698107547381, 12094.213876098025, 12481.875181248071, 10611.151107911503, 10894.128469722245, 10990.725231868948, 11296.943515282699, 11342.546298147981, 9625.0, 9701.805963880824, 9806.75483112928, 10002.699919002442, 10496.16030717556, 8555.443896146731, 8919.93444457775, 9130.726078217664, 10010.44942528168, 10014.449205293779], "unit": "ms", "name": "yui.html", "value": 6462.565579796975}], "name": "dromaeo_css", "value": 7078.193865234265}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 115.0, 113.0, 111.0, 123.0, 110.0, 111.0, 110.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [156.0, 127.0, 153.0, 164.0, 128.0, 151.0, 150.0, 129.0, 167.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [160.0, 163.0, 161.0, 163.0, 163.0, 162.0, 162.0, 162.0, 173.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 72.0, 73.0, 78.0, 71.0, 138.0, 73.0, 71.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.1}, {"lowerIsBetter": true, "replicates": [93.0, 94.0, 136.0, 93.0, 93.0, 93.0, 135.0, 94.0, 94.0, 142.0], "unit": "ms", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 111.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [150.0, 147.0, 146.0, 148.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 98.0, 97.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 63.0, 63.0, 64.0, 62.0, 63.0, 62.0, 70.0, 62.0], "unit": "ms", "name": "json-parse-financial", "value": 63.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 71.0, 71.0, 72.0, 71.0, 71.0, 70.0, 79.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 72.0}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 85.0, 85.0, 86.0, 86.0, 86.0, 86.0, 86.0, 95.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [126.0, 116.0, 130.0, 119.0, 117.0, 126.0, 118.0, 131.0, 115.0, 131.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [143.0, 160.0, 152.0, 163.0, 152.0, 143.0, 142.0, 151.0, 151.0, 163.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 152.0}, {"lowerIsBetter": true, "replicates": [72.0, 67.0, 70.0, 67.0, 69.0, 71.0, 67.0, 69.0, 69.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1524.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.61649346295675], "unit": "score", "name": "Richards", "value": 210.61173199999993}, {"lowerIsBetter": false, "replicates": [188.14675446848543], "unit": "score", "name": "DeltaBlue", "value": 351.41717}, {"lowerIsBetter": false, "replicates": [282.7254735651682], "unit": "score", "name": "Encrypt", "value": 941.4821969999996}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1067.2358591248667], "unit": "score", "name": "RayTrace", "value": 693.3696929999998}, {"lowerIsBetter": false, "replicates": [736.9196757553427], "unit": "score", "name": "Earley", "value": 904.3902909999999}, {"lowerIsBetter": false, "replicates": [12072.289156626506], "unit": "score", "name": "Boyer", "value": 55.20601696606782}, {"lowerIsBetter": false, "replicates": [25000.0], "unit": "score", "name": "RegExp", "value": 36.43939999999999}, {"lowerIsBetter": false, "replicates": [659.016393442623], "unit": "score", "name": "Splay", "value": 123.65549751243779}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21138.26892501339}]} 22:22:38 INFO - RETURN: dromaeo_css: 7078.19 22:22:38 INFO - RETURN: kraken: 1524.40 22:22:38 INFO - RETURN: v8_7: 21138.27 22:22:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21138.27"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1524.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7078.19"}}} 22:22:38 INFO - Return code: 0 22:22:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:22:39 INFO - # TBPL SUCCESS # 22:22:39 INFO - Running post-action listener: _resource_record_post_action 22:22:39 INFO - Running post-run listener: _resource_record_post_run 22:22:40 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 526274560; Read time: 12; Write time: 431924 22:22:40 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 237273088; Read time: 0; Write time: 276280 22:22:40 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 277463040; Read time: 12; Write time: 151200 22:22:40 INFO - Running post-run listener: _upload_blobber_files 22:22:40 INFO - Blob upload gear active. 22:22:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:22:40 INFO - Copying logs to upload dir... 22:22:40 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.320177 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-28 22:22:38.771887) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-28 22:22:38.775773) ========= 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=919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010122 build_url: 'https://queue.taskcluster.net/v1/task/f4kv82gxRM-whoUkH9tj_Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-28 22:22:38.828557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 22:22:38.829042) ========= 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=919420d7ee4ef147bef0346300000385-1448763203.451404-1030217638 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004605 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 22:22:38.880568) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-28 22:22:38.881059) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-28 22:22:38.881544) ========= ========= Total master_lag: 0.27 =========