builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-069 starttime: 1447774866.55 results: success (0) buildid: 20151117053006 builduid: d56c084179be45cdb07ebef1ade7bcb1 revision: b8be6b563c8ab1a42071e5aecee81b96910a50ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:06.554534) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:06.554903) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:06.555216) ========= 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=d96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007309 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:06.577131) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:06.577405) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:06.591246) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:06.591544) ========= 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=d96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:06.640655) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:06.640973) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:06.641357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:06.641641) ========= 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=d96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 07:41:08-- 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% 226M=0s 2015-11-17 07:41:08 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196442 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:06.852356) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:06.852645) ========= 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=d96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016127 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:06.903397) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 07:41:06.903890) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b8be6b563c8ab1a42071e5aecee81b96910a50ac --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 b8be6b563c8ab1a42071e5aecee81b96910a50ac --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=d96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 07:41:08,600 truncating revision to first 12 chars 2015-11-17 07:41:08,600 Setting DEBUG logging. 2015-11-17 07:41:08,600 attempt 1/10 2015-11-17 07:41:08,600 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b8be6b563c8a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 07:41:09,580 unpacking tar archive at: fx-team-b8be6b563c8a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.227986 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-17 07:41:08.149977) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:08.150641) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:08.162089) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:08.162433) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 07:41:08.162954) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-17 07:41:08.163314) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:41:09 INFO - MultiFileLogger online at 20151117 07:41:09 in /builds/slave/test-pgo 07:41:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:41:09 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:41:09 INFO - {'append_to_log': False, 07:41:09 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:41:09 INFO - 'blob_upload_branch': 'Fx-Team', 07:41:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:41:09 INFO - 'branch': 'Fx-Team', 07:41:09 INFO - 'buildbot_json_path': 'buildprops.json', 07:41:09 INFO - 'config_files': ('talos/linux_config.py',), 07:41:09 INFO - 'default_actions': ('clobber', 07:41:09 INFO - 'read-buildbot-config', 07:41:09 INFO - 'download-and-extract', 07:41:09 INFO - 'populate-webroot', 07:41:09 INFO - 'create-virtualenv', 07:41:09 INFO - 'install', 07:41:09 INFO - 'run-tests'), 07:41:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:41:09 INFO - 'download_minidump_stackwalk': True, 07:41:09 INFO - 'download_symbols': 'ondemand', 07:41:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:41:09 INFO - 'tooltool.py': '/tools/tooltool.py', 07:41:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:41:09 INFO - '/tools/misc-python/virtualenv.py')}, 07:41:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:41:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:41:09 INFO - 'installer_path': 'installer.exe', 07:41:09 INFO - 'log_level': 'info', 07:41:09 INFO - 'log_name': 'talos', 07:41:09 INFO - 'log_to_console': True, 07:41:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:41:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:41:09 INFO - 'opt_config_files': (), 07:41:09 INFO - 'pip_index': False, 07:41:09 INFO - 'sps_profile': False, 07:41:09 INFO - 'sps_profile_interval': 0, 07:41:09 INFO - 'suite': 'dromaeojs', 07:41:09 INFO - 'system_bits': '64', 07:41:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:41:09 INFO - 'title': 'talos-linux64-ix-069', 07:41:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:41:09 INFO - 'use_talos_json': True, 07:41:09 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:41:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:41:09 INFO - 'work_dir': 'build'} 07:41:09 INFO - ##### 07:41:09 INFO - ##### Running clobber step. 07:41:09 INFO - ##### 07:41:09 INFO - Running pre-action listener: _resource_record_pre_action 07:41:09 INFO - Running main action method: clobber 07:41:09 INFO - rmtree: /builds/slave/test-pgo/build 07:41:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:41:10 INFO - Running post-action listener: _resource_record_post_action 07:41:10 INFO - ##### 07:41:10 INFO - ##### Running read-buildbot-config step. 07:41:10 INFO - ##### 07:41:10 INFO - Running pre-action listener: _resource_record_pre_action 07:41:10 INFO - Running main action method: read_buildbot_config 07:41:10 INFO - Using buildbot properties: 07:41:10 INFO - { 07:41:10 INFO - "properties": { 07:41:10 INFO - "buildnumber": 326, 07:41:10 INFO - "product": "firefox", 07:41:10 INFO - "script_repo_revision": "production", 07:41:10 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:41:10 INFO - "repository": "", 07:41:10 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 07:41:10 INFO - "buildid": "20151117053006", 07:41:10 INFO - "slavename": "talos-linux64-ix-069", 07:41:10 INFO - "pgo_build": "True", 07:41:10 INFO - "basedir": "/builds/slave/test-pgo", 07:41:10 INFO - "project": "", 07:41:10 INFO - "platform": "ubuntu64_hw", 07:41:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:41:10 INFO - "slavebuilddir": "test", 07:41:10 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 07:41:10 INFO - "branch": "fx-team", 07:41:10 INFO - "repo_path": "integration/fx-team", 07:41:10 INFO - "stage_platform": "linux64-pgo", 07:41:10 INFO - "builduid": "d56c084179be45cdb07ebef1ade7bcb1", 07:41:10 INFO - "revision": "b8be6b563c8ab1a42071e5aecee81b96910a50ac" 07:41:10 INFO - }, 07:41:10 INFO - "sourcestamp": { 07:41:10 INFO - "repository": "", 07:41:10 INFO - "hasPatch": false, 07:41:10 INFO - "project": "", 07:41:10 INFO - "branch": "fx-team-linux64-pgo-talos", 07:41:10 INFO - "changes": [ 07:41:10 INFO - { 07:41:10 INFO - "category": null, 07:41:10 INFO - "files": [ 07:41:10 INFO - { 07:41:10 INFO - "url": null, 07:41:10 INFO - "name": "https://queue.taskcluster.net/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 07:41:10 INFO - } 07:41:10 INFO - ], 07:41:10 INFO - "repository": "", 07:41:10 INFO - "rev": "b8be6b563c8ab1a42071e5aecee81b96910a50ac", 07:41:10 INFO - "who": "sendchange", 07:41:10 INFO - "when": 1447774791, 07:41:10 INFO - "number": 6672308, 07:41:10 INFO - "comments": "", 07:41:10 INFO - "project": "", 07:41:10 INFO - "at": "Tue 17 Nov 2015 07:39:51", 07:41:10 INFO - "branch": "fx-team-linux64-pgo-talos", 07:41:10 INFO - "revlink": "", 07:41:10 INFO - "properties": [ 07:41:10 INFO - [ 07:41:10 INFO - "buildid", 07:41:10 INFO - "20151117053006", 07:41:10 INFO - "Change" 07:41:10 INFO - ], 07:41:10 INFO - [ 07:41:10 INFO - "builduid", 07:41:10 INFO - "d56c084179be45cdb07ebef1ade7bcb1", 07:41:10 INFO - "Change" 07:41:10 INFO - ], 07:41:10 INFO - [ 07:41:10 INFO - "pgo_build", 07:41:10 INFO - "True", 07:41:10 INFO - "Change" 07:41:10 INFO - ] 07:41:10 INFO - ], 07:41:10 INFO - "revision": "b8be6b563c8ab1a42071e5aecee81b96910a50ac" 07:41:10 INFO - } 07:41:10 INFO - ], 07:41:10 INFO - "revision": "b8be6b563c8ab1a42071e5aecee81b96910a50ac" 07:41:10 INFO - } 07:41:10 INFO - } 07:41:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 07:41:10 INFO - Running post-action listener: _resource_record_post_action 07:41:10 INFO - ##### 07:41:10 INFO - ##### Running download-and-extract step. 07:41:10 INFO - ##### 07:41:10 INFO - Running pre-action listener: _resource_record_pre_action 07:41:10 INFO - Running main action method: download_and_extract 07:41:10 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:41:10 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')]} 07:41:10 INFO - https://queue.taskcluster.net/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:41:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/test_packages.json 07:41:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/test_packages.json 07:41:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:41:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:41:10 INFO - Downloaded 1302 bytes. 07:41:10 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:41:10 INFO - Using the following test package requirements: 07:41:11 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:41:11 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:41:11 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:11 INFO - u'jsshell-linux-x86_64.zip'], 07:41:11 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:41:11 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:41:11 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:41:11 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:41:11 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:41:11 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 07:41:11 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 07:41:11 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:41:11 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:41: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')]} 07:41:11 INFO - https://queue.taskcluster.net/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:41:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:41:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:41:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/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 07:41:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/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 07:41:11 INFO - Downloaded 22459164 bytes. 07:41:11 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 07:41:11 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:41:11 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 07:41:13 INFO - Return code: 0 07:41:13 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 07:41:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:13 INFO - https://queue.taskcluster.net/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:41:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:41:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:41:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/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 07:41:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/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 07:41:14 INFO - Downloaded 22459164 bytes. 07:41:14 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 07:41:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 07:41:14 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 07:41:15 INFO - Return code: 0 07:41:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:15 INFO - https://queue.taskcluster.net/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:41:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:41:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:41:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/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 07:41:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/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 07:41:17 INFO - Downloaded 11131693 bytes. 07:41:17 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 07:41:17 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 07:41:17 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 07:41:17 INFO - Return code: 0 07:41:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:17 INFO - https://queue.taskcluster.net/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:41:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:41:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:41:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/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 07:41:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TirxCQ1JQkK2lQEn1bNSsg/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 07:41:18 INFO - Downloaded 57174589 bytes. 07:41:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:41:18 INFO - mkdir: /builds/slave/test-pgo/properties 07:41:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:41:18 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:41:18 INFO - Contents: 07:41:18 INFO - build_url:https://queue.taskcluster.net/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 07:41:18 INFO - Running post-action listener: _resource_record_post_action 07:41:18 INFO - Running post-action listener: set_extra_try_arguments 07:41:18 INFO - ##### 07:41:18 INFO - ##### Running populate-webroot step. 07:41:18 INFO - ##### 07:41:18 INFO - Running pre-action listener: _resource_record_pre_action 07:41:18 INFO - Running main action method: populate_webroot 07:41:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:41:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:41:18 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 07:41:18 INFO - '../fennec_ids.txt'], 07:41:18 INFO - 'tests': ['tcheck2']}, 07:41:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:41:18 INFO - '--tppagecycles', 07:41:18 INFO - '7'], 07:41:18 INFO - 'tests': ['tsvgm']}}, 07:41:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:41:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:41:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:41:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:41:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:41:18 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:41:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:18 INFO - 'talos_options': ['--e10s'], 07:41:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:18 INFO - 'tests': ['damp', 'tps']}, 07:41:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:18 INFO - 'talos_options': ['--e10s'], 07:41:18 INFO - 'tests': ['damp', 'tps']}, 07:41:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:41:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:41:18 INFO - 'other': {'tests': ['a11yr', 07:41:18 INFO - 'ts_paint', 07:41:18 INFO - 'tpaint', 07:41:18 INFO - 'sessionrestore', 07:41:18 INFO - 'sessionrestore_no_auto_restore']}, 07:41:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:41:18 INFO - 'tests': ['a11yr', 07:41:18 INFO - 'ts_paint', 07:41:18 INFO - 'tpaint', 07:41:18 INFO - 'sessionrestore', 07:41:18 INFO - 'sessionrestore_no_auto_restore']}, 07:41:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:41:18 INFO - 'tests': ['a11yr', 07:41:18 INFO - 'ts_paint', 07:41:18 INFO - 'tpaint', 07:41:18 INFO - 'sessionrestore', 07:41:18 INFO - 'sessionrestore_no_auto_restore']}, 07:41:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:41:18 INFO - 'tests': ['a11yr', 07:41:18 INFO - 'ts_paint', 07:41:18 INFO - 'tpaint', 07:41:18 INFO - 'sessionrestore', 07:41:18 INFO - 'sessionrestore_no_auto_restore']}, 07:41:18 INFO - 'other_l64': {'tests': ['a11yr', 07:41:18 INFO - 'ts_paint', 07:41:18 INFO - 'tpaint', 07:41:18 INFO - 'sessionrestore', 07:41:18 INFO - 'sessionrestore_no_auto_restore']}, 07:41:18 INFO - 'other_nol64': {'tests': ['a11yr', 07:41:18 INFO - 'ts_paint', 07:41:18 INFO - 'tpaint', 07:41:18 INFO - 'sessionrestore', 07:41:18 INFO - 'sessionrestore_no_auto_restore']}, 07:41:18 INFO - 'svgr': {'tests': ['tsvgx', 07:41:18 INFO - 'tsvgr_opacity', 07:41:18 INFO - 'tart', 07:41:18 INFO - 'tscrollx', 07:41:18 INFO - 'cart']}, 07:41:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:41:18 INFO - 'tests': ['tsvgx', 07:41:18 INFO - 'tsvgr_opacity', 07:41:18 INFO - 'tart', 07:41:18 INFO - 'tscrollx', 07:41:18 INFO - 'cart']}, 07:41:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:18 INFO - 'tests': ['tp5o']}, 07:41:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:18 INFO - 'talos_options': ['--e10s'], 07:41:18 INFO - 'tests': ['tp5o']}, 07:41:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:18 INFO - 'talos_options': ['--xperf_path', 07:41:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:18 INFO - 'tests': ['tp5n']}, 07:41:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:41:18 INFO - 'talos_options': ['--e10s', 07:41:18 INFO - '--xperf_path', 07:41:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:18 INFO - 'tests': ['tp5n']}}, 07:41:18 INFO - 'talos.zip': {'path': '', 07:41:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:41:18 INFO - Running post-action listener: _resource_record_post_action 07:41:18 INFO - ##### 07:41:18 INFO - ##### Running create-virtualenv step. 07:41:18 INFO - ##### 07:41:18 INFO - Running pre-action listener: _resource_record_pre_action 07:41:18 INFO - Running main action method: create_virtualenv 07:41:18 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:41:18 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 07:41:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:41:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:41:18 INFO - Using real prefix '/usr' 07:41:18 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:41:19 INFO - Installing distribute.............................................................................................................................................................................................done. 07:41:21 INFO - Installing pip.................done. 07:41:21 INFO - Return code: 0 07:41:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8752c05c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfec3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758c0>, '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 0x1022420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10228b0>, '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': 'd96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278', '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 07:41:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 07:41:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:41:21 INFO - Using env: {'DISPLAY': ':0', 07:41:21 INFO - 'HOME': '/home/cltbld', 07:41:21 INFO - 'LANG': 'en_US.UTF-8', 07:41:21 INFO - 'LANGUAGE': 'en_US:en', 07:41:21 INFO - 'LOGNAME': 'cltbld', 07:41:21 INFO - 'MAIL': '/var/mail/cltbld', 07:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:21 INFO - 'MOZ_NO_REMOTE': '1', 07:41:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:21 INFO - 'NO_EM_RESTART': '1', 07:41:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:41:21 INFO - 'PWD': '/builds/slave/test-pgo', 07:41:21 INFO - 'SHELL': '/bin/bash', 07:41:21 INFO - 'SHLVL': '1', 07:41:21 INFO - 'TERM': 'linux', 07:41:21 INFO - 'TMOUT': '86400', 07:41:21 INFO - 'USER': 'cltbld', 07:41:21 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278', 07:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:21 INFO - '_': '/tools/buildbot/bin/python'} 07:41:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:21 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 07:41:21 INFO - Cleaning up... 07:41:21 INFO - Return code: 0 07:41:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8752c05c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfec3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758c0>, '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 0x1022420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10228b0>, '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': 'd96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278', '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 07:41:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 07:41:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:41:21 INFO - Using env: {'DISPLAY': ':0', 07:41:21 INFO - 'HOME': '/home/cltbld', 07:41:21 INFO - 'LANG': 'en_US.UTF-8', 07:41:21 INFO - 'LANGUAGE': 'en_US:en', 07:41:21 INFO - 'LOGNAME': 'cltbld', 07:41:21 INFO - 'MAIL': '/var/mail/cltbld', 07:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:21 INFO - 'MOZ_NO_REMOTE': '1', 07:41:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:21 INFO - 'NO_EM_RESTART': '1', 07:41:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:41:21 INFO - 'PWD': '/builds/slave/test-pgo', 07:41:21 INFO - 'SHELL': '/bin/bash', 07:41:21 INFO - 'SHLVL': '1', 07:41:21 INFO - 'TERM': 'linux', 07:41:21 INFO - 'TMOUT': '86400', 07:41:21 INFO - 'USER': 'cltbld', 07:41:21 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278', 07:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:21 INFO - '_': '/tools/buildbot/bin/python'} 07:41:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:21 INFO - Downloading/unpacking psutil>=0.7.1 07:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:23 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 07:41:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:41:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:41:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:23 INFO - Installing collected packages: psutil 07:41:23 INFO - Running setup.py install for psutil 07:41:23 INFO - building 'psutil._psutil_linux' extension 07:41:23 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 07:41:24 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 07:41:24 INFO - building 'psutil._psutil_posix' extension 07:41:24 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 07:41:24 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 07:41:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:24 INFO - Successfully installed psutil 07:41:24 INFO - Cleaning up... 07:41:24 INFO - Return code: 0 07:41:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:41:24 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')]} 07:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:24 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')]} 07:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:24 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 0x7f8752c05c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfec3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758c0>, '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 0x1022420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10228b0>, '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': 'd96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278', '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 07:41:24 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 07:41:24 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 07:41:24 INFO - Using env: {'DISPLAY': ':0', 07:41:24 INFO - 'HOME': '/home/cltbld', 07:41:24 INFO - 'LANG': 'en_US.UTF-8', 07:41:24 INFO - 'LANGUAGE': 'en_US:en', 07:41:24 INFO - 'LOGNAME': 'cltbld', 07:41:24 INFO - 'MAIL': '/var/mail/cltbld', 07:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:24 INFO - 'MOZ_NO_REMOTE': '1', 07:41:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:24 INFO - 'NO_EM_RESTART': '1', 07:41:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:41:24 INFO - 'PWD': '/builds/slave/test-pgo', 07:41:24 INFO - 'SHELL': '/bin/bash', 07:41:24 INFO - 'SHLVL': '1', 07:41:24 INFO - 'TERM': 'linux', 07:41:24 INFO - 'TMOUT': '86400', 07:41:24 INFO - 'USER': 'cltbld', 07:41:24 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278', 07:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:24 INFO - '_': '/tools/buildbot/bin/python'} 07:41:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:26 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:41:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:41:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:41:26 INFO - Installing collected packages: mozsystemmonitor 07:41:26 INFO - Running setup.py install for mozsystemmonitor 07:41:26 INFO - Successfully installed mozsystemmonitor 07:41:26 INFO - Cleaning up... 07:41:26 INFO - Return code: 0 07:41:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:41:26 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')]} 07:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:26 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')]} 07:41:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:26 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 0x7f8752c05c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfec3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758c0>, '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 0x1022420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10228b0>, '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': 'd96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278', '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 07:41:26 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 07:41:26 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 07:41:26 INFO - Using env: {'DISPLAY': ':0', 07:41:26 INFO - 'HOME': '/home/cltbld', 07:41:26 INFO - 'LANG': 'en_US.UTF-8', 07:41:26 INFO - 'LANGUAGE': 'en_US:en', 07:41:26 INFO - 'LOGNAME': 'cltbld', 07:41:26 INFO - 'MAIL': '/var/mail/cltbld', 07:41:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:26 INFO - 'MOZ_NO_REMOTE': '1', 07:41:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:26 INFO - 'NO_EM_RESTART': '1', 07:41:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:41:26 INFO - 'PWD': '/builds/slave/test-pgo', 07:41:26 INFO - 'SHELL': '/bin/bash', 07:41:26 INFO - 'SHLVL': '1', 07:41:26 INFO - 'TERM': 'linux', 07:41:26 INFO - 'TMOUT': '86400', 07:41:26 INFO - 'USER': 'cltbld', 07:41:26 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278', 07:41:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:26 INFO - '_': '/tools/buildbot/bin/python'} 07:41:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:26 INFO - Downloading/unpacking blobuploader==1.2.4 07:41:26 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 07:41:26 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 07:41:26 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 07:41:26 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 07:41:26 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 07:41:26 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 07:41:28 INFO - Downloading blobuploader-1.2.4.tar.gz 07:41:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:41:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:41:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:41:28 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 07:41:28 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 07:41:28 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 07:41:28 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 07:41:28 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 07:41:28 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 07:41:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:41:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:41:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:41:28 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 07:41:28 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 07:41:28 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 07:41:28 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 07:41:28 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 07:41:28 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 07:41:28 INFO - Downloading docopt-0.6.1.tar.gz 07:41:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:41:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:41:28 INFO - Installing collected packages: blobuploader, requests, docopt 07:41:28 INFO - Running setup.py install for blobuploader 07:41:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:41:29 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:41:29 INFO - Running setup.py install for requests 07:41:29 INFO - Running setup.py install for docopt 07:41:29 INFO - Successfully installed blobuploader requests docopt 07:41:29 INFO - Cleaning up... 07:41:29 INFO - Return code: 0 07:41:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:41:29 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')]} 07:41:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:29 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')]} 07:41:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:29 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 0x7f8752c05c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfec3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758c0>, '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 0x1022420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10228b0>, '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': 'd96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278', '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 07:41:29 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 07:41:29 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 07:41:29 INFO - Using env: {'DISPLAY': ':0', 07:41:29 INFO - 'HOME': '/home/cltbld', 07:41:29 INFO - 'LANG': 'en_US.UTF-8', 07:41:29 INFO - 'LANGUAGE': 'en_US:en', 07:41:29 INFO - 'LOGNAME': 'cltbld', 07:41:29 INFO - 'MAIL': '/var/mail/cltbld', 07:41:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:29 INFO - 'MOZ_NO_REMOTE': '1', 07:41:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:29 INFO - 'NO_EM_RESTART': '1', 07:41:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:41:29 INFO - 'PWD': '/builds/slave/test-pgo', 07:41:29 INFO - 'SHELL': '/bin/bash', 07:41:29 INFO - 'SHLVL': '1', 07:41:29 INFO - 'TERM': 'linux', 07:41:29 INFO - 'TMOUT': '86400', 07:41:29 INFO - 'USER': 'cltbld', 07:41:29 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278', 07:41:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:29 INFO - '_': '/tools/buildbot/bin/python'} 07:41:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:41:29 INFO - Running setup.py (path:/tmp/pip-YBcFdx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:41:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:41:29 INFO - Running setup.py (path:/tmp/pip-HkWB9B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:41:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:41:29 INFO - Running setup.py (path:/tmp/pip-eswvot-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:41:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:41:29 INFO - Running setup.py (path:/tmp/pip-iwQKNc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:41:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:41:30 INFO - Running setup.py (path:/tmp/pip-uKxor6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:41:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:41:30 INFO - Running setup.py (path:/tmp/pip-5OjwvI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:41:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:41:30 INFO - Running setup.py (path:/tmp/pip-cFgq5z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:41:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:41:30 INFO - Running setup.py (path:/tmp/pip-OZbsrZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:41:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:41:30 INFO - Running setup.py (path:/tmp/pip-vNNsnt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:41:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:41:30 INFO - Running setup.py (path:/tmp/pip-6p6Mlm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:41:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:41:30 INFO - Running setup.py (path:/tmp/pip-PfsBKo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:41:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:41:30 INFO - Running setup.py (path:/tmp/pip-Imp0sO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:41:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:41:30 INFO - Running setup.py (path:/tmp/pip-grOxbx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:41:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:41:30 INFO - Running setup.py (path:/tmp/pip-Nu7BXU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:41:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:41:30 INFO - Running setup.py (path:/tmp/pip-qBvsOr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:41:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:41:30 INFO - Running setup.py (path:/tmp/pip-ro47JJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:41:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:41:30 INFO - Running setup.py (path:/tmp/pip-cV3ujp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:41:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:41:30 INFO - Running setup.py install for manifestparser 07:41:31 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:41:31 INFO - Running setup.py install for mozcrash 07:41:31 INFO - Running setup.py install for mozdebug 07:41:31 INFO - Running setup.py install for mozdevice 07:41:31 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:41:31 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:41:31 INFO - Running setup.py install for mozfile 07:41:31 INFO - Running setup.py install for mozhttpd 07:41:31 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:41:31 INFO - Running setup.py install for mozinfo 07:41:31 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:41:31 INFO - Running setup.py install for mozInstall 07:41:31 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:41:31 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:41:31 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:41:31 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:41:31 INFO - Running setup.py install for mozleak 07:41:31 INFO - Running setup.py install for mozlog 07:41:31 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:41:31 INFO - Running setup.py install for moznetwork 07:41:32 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:41:32 INFO - Running setup.py install for mozprocess 07:41:32 INFO - Running setup.py install for mozprofile 07:41:32 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:41:32 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:41:32 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:41:32 INFO - Running setup.py install for mozrunner 07:41:32 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:41:32 INFO - Running setup.py install for mozscreenshot 07:41:32 INFO - Running setup.py install for moztest 07:41:32 INFO - Running setup.py install for mozversion 07:41:32 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:41:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:41:32 INFO - Cleaning up... 07:41:32 INFO - Return code: 0 07:41:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:41:32 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')]} 07:41:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:32 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')]} 07:41:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:32 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 0x7f8752c05c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfec3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758c0>, '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 0x1022420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10228b0>, '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': 'd96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278', '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 07:41:32 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 07:41:32 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 07:41:32 INFO - Using env: {'DISPLAY': ':0', 07:41:32 INFO - 'HOME': '/home/cltbld', 07:41:32 INFO - 'LANG': 'en_US.UTF-8', 07:41:32 INFO - 'LANGUAGE': 'en_US:en', 07:41:32 INFO - 'LOGNAME': 'cltbld', 07:41:32 INFO - 'MAIL': '/var/mail/cltbld', 07:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:32 INFO - 'MOZ_NO_REMOTE': '1', 07:41:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:32 INFO - 'NO_EM_RESTART': '1', 07:41:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:41:32 INFO - 'PWD': '/builds/slave/test-pgo', 07:41:32 INFO - 'SHELL': '/bin/bash', 07:41:32 INFO - 'SHLVL': '1', 07:41:32 INFO - 'TERM': 'linux', 07:41:32 INFO - 'TMOUT': '86400', 07:41:32 INFO - 'USER': 'cltbld', 07:41:32 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278', 07:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:32 INFO - '_': '/tools/buildbot/bin/python'} 07:41:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:41:32 INFO - Running setup.py (path:/tmp/pip-Gm5ugg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:41:33 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)) 07:41:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:41:33 INFO - Running setup.py (path:/tmp/pip-JVNo_W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:41:33 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)) 07:41:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:41:33 INFO - Running setup.py (path:/tmp/pip-tCk04x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:41:33 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)) 07:41:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:41:33 INFO - Running setup.py (path:/tmp/pip-Uuiu92-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:41:33 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)) 07:41:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:41:33 INFO - Running setup.py (path:/tmp/pip-RFY9iy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:41:33 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)) 07:41:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:41:33 INFO - Running setup.py (path:/tmp/pip-zNr_Ha-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:41:33 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)) 07:41:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:41:33 INFO - Running setup.py (path:/tmp/pip-x0C6gV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:41:33 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)) 07:41:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:41:33 INFO - Running setup.py (path:/tmp/pip-y26qaX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:41:33 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)) 07:41:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:41:33 INFO - Running setup.py (path:/tmp/pip-x8IEPx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:41:33 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)) 07:41:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:41:33 INFO - Running setup.py (path:/tmp/pip-BTfLBx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:41:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 07:41:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:41:33 INFO - Running setup.py (path:/tmp/pip-aIQN7m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:41:33 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)) 07:41:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:41:33 INFO - Running setup.py (path:/tmp/pip-5pNyEe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:41:33 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)) 07:41:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:41:33 INFO - Running setup.py (path:/tmp/pip-tQ1IRG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:41:33 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)) 07:41:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:41:33 INFO - Running setup.py (path:/tmp/pip-PmvhaD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:41:33 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)) 07:41:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:41:33 INFO - Running setup.py (path:/tmp/pip-CdQp9e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:41:34 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)) 07:41:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:41:34 INFO - Running setup.py (path:/tmp/pip-cWSKOV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:41:34 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)) 07:41:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:41:34 INFO - Running setup.py (path:/tmp/pip-7VFw7J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:41:34 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)) 07:41:34 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)) 07:41:34 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)) 07:41:34 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)) 07:41:34 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)) 07:41:34 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)) 07:41:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:41:34 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 07:41:34 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 07:41:34 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 07:41:34 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 07:41:34 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 07:41:34 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 07:41:35 INFO - Downloading blessings-1.5.1.tar.gz 07:41:35 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 07:41:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:41:35 INFO - Installing collected packages: blessings 07:41:35 INFO - Running setup.py install for blessings 07:41:36 INFO - Successfully installed blessings 07:41:36 INFO - Cleaning up... 07:41:36 INFO - Return code: 0 07:41:36 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:41:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:41:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:41:36 INFO - Reading from file tmpfile_stdout 07:41:36 INFO - Current package versions: 07:41:36 INFO - argparse == 1.2.1 07:41:36 INFO - blessings == 1.5.1 07:41:36 INFO - blobuploader == 1.2.4 07:41:36 INFO - docopt == 0.6.1 07:41:36 INFO - manifestparser == 1.1 07:41:36 INFO - mozInstall == 1.12 07:41:36 INFO - mozcrash == 0.16 07:41:36 INFO - mozdebug == 0.1 07:41:36 INFO - mozdevice == 0.47 07:41:36 INFO - mozfile == 1.2 07:41:36 INFO - mozhttpd == 0.7 07:41:36 INFO - mozinfo == 0.9 07:41:36 INFO - mozleak == 0.1 07:41:36 INFO - mozlog == 3.0 07:41:36 INFO - moznetwork == 0.27 07:41:36 INFO - mozprocess == 0.22 07:41:36 INFO - mozprofile == 0.27 07:41:36 INFO - mozrunner == 6.11 07:41:36 INFO - mozscreenshot == 0.1 07:41:36 INFO - mozsystemmonitor == 0.0 07:41:36 INFO - moztest == 0.7 07:41:36 INFO - mozversion == 1.4 07:41:36 INFO - psutil == 3.1.1 07:41:36 INFO - requests == 1.2.3 07:41:36 INFO - wsgiref == 0.1.2 07:41:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:41: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')]} 07:41:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41: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')]} 07:41:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f8752c05c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf2b6c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfec3d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10758c0>, '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 0x1022420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10228b0>, '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': 'd96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278', '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 07:41:36 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 07:41:36 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 07:41:36 INFO - Using env: {'DISPLAY': ':0', 07:41:36 INFO - 'HOME': '/home/cltbld', 07:41:36 INFO - 'LANG': 'en_US.UTF-8', 07:41:36 INFO - 'LANGUAGE': 'en_US:en', 07:41:36 INFO - 'LOGNAME': 'cltbld', 07:41:36 INFO - 'MAIL': '/var/mail/cltbld', 07:41:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:36 INFO - 'MOZ_NO_REMOTE': '1', 07:41:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:36 INFO - 'NO_EM_RESTART': '1', 07:41:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:41:36 INFO - 'PWD': '/builds/slave/test-pgo', 07:41:36 INFO - 'SHELL': '/bin/bash', 07:41:36 INFO - 'SHLVL': '1', 07:41:36 INFO - 'TERM': 'linux', 07:41:36 INFO - 'TMOUT': '86400', 07:41:36 INFO - 'USER': 'cltbld', 07:41:36 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278', 07:41:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:36 INFO - '_': '/tools/buildbot/bin/python'} 07:41:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:36 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)) 07:41:36 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)) 07:41:36 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)) 07:41:36 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)) 07:41:36 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)) 07:41:36 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)) 07:41:36 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)) 07:41:36 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)) 07:41:36 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)) 07:41:36 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)) 07:41:36 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)) 07:41:36 INFO - Cleaning up... 07:41:36 INFO - Return code: 0 07:41:36 INFO - Running post-action listener: _resource_record_post_action 07:41:36 INFO - Running post-action listener: _start_resource_monitoring 07:41:36 INFO - Starting resource monitoring. 07:41:36 INFO - ##### 07:41:36 INFO - ##### Running install step. 07:41:36 INFO - ##### 07:41:36 INFO - Running pre-action listener: _resource_record_pre_action 07:41:36 INFO - Running main action method: install 07:41:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:41:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:41:36 INFO - Reading from file tmpfile_stdout 07:41:36 INFO - Detecting whether we're running mozinstall >=1.0... 07:41:36 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:41:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:41:36 INFO - Reading from file tmpfile_stdout 07:41:36 INFO - Output received: 07:41:36 INFO - Usage: mozinstall [options] installer 07:41:36 INFO - Options: 07:41:36 INFO - -h, --help show this help message and exit 07:41:36 INFO - -d DEST, --destination=DEST 07:41:36 INFO - Directory to install application into. [default: 07:41:36 INFO - "/builds/slave/test-pgo"] 07:41:36 INFO - --app=APP Application being installed. [default: firefox] 07:41:36 INFO - mkdir: /builds/slave/test-pgo/build/application 07:41:36 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'] 07:41:36 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 07:41:51 INFO - Reading from file tmpfile_stdout 07:41:51 INFO - Output received: 07:41:51 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:41:51 INFO - Running post-action listener: _resource_record_post_action 07:41:51 INFO - ##### 07:41:51 INFO - ##### Running run-tests step. 07:41:51 INFO - ##### 07:41:51 INFO - Running pre-action listener: _resource_record_pre_action 07:41:51 INFO - Running main action method: run_tests 07:41:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:41:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:41:51 INFO - Python 2.7.3 07:41:51 INFO - Return code: 0 07:41:51 INFO - grabbing minidump binary from tooltool 07:41:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:41:51 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 0x10758c0>, '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 0x1022420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10228b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:41:51 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 07:41:51 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 07:41:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:41:51 INFO - Return code: 0 07:41:51 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:41:51 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:41:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:41:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:41:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:41:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 07:41:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-069 --webServer localhost 07:41:51 INFO - Using env: {'DISPLAY': ':0', 07:41:51 INFO - 'HOME': '/home/cltbld', 07:41:51 INFO - 'LANG': 'en_US.UTF-8', 07:41:51 INFO - 'LANGUAGE': 'en_US:en', 07:41:51 INFO - 'LOGNAME': 'cltbld', 07:41:51 INFO - 'MAIL': '/var/mail/cltbld', 07:41:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:41:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:41:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:51 INFO - 'MOZ_NO_REMOTE': '1', 07:41:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:41:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:51 INFO - 'NO_EM_RESTART': '1', 07:41:51 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:41:51 INFO - 'PWD': '/builds/slave/test-pgo', 07:41:51 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:41:51 INFO - 'SHELL': '/bin/bash', 07:41:51 INFO - 'SHLVL': '1', 07:41:51 INFO - 'TERM': 'linux', 07:41:51 INFO - 'TMOUT': '86400', 07:41:51 INFO - 'USER': 'cltbld', 07:41:51 INFO - 'XDG_SESSION_COOKIE': 'd96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278', 07:41:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:51 INFO - '_': '/tools/buildbot/bin/python'} 07:41:51 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-069', '--webServer', 'localhost'] with output_timeout 3600 07:41:52 INFO - mozversion INFO | application_buildid: 20151117053006 07:41:52 INFO - mozversion INFO | application_changeset: b8be6b563c8ab1a42071e5aecee81b96910a50ac 07:41:52 INFO - mozversion INFO | application_display_name: Nightly 07:41:52 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:41:52 INFO - mozversion INFO | application_name: Firefox 07:41:52 INFO - mozversion INFO | application_remotingname: firefox 07:41:52 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 07:41:52 INFO - mozversion INFO | application_vendor: Mozilla 07:41:52 INFO - mozversion INFO | application_version: 45.0a1 07:41:52 INFO - mozversion INFO | platform_buildid: 20151117053006 07:41:52 INFO - mozversion INFO | platform_changeset: b8be6b563c8ab1a42071e5aecee81b96910a50ac 07:41:52 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 07:41:52 INFO - mozversion INFO | platform_version: 45.0a1 07:41:52 INFO - 2015-11-17 07:41:52,056 DEBUG : using testdate: 1447774912 07:41:52 INFO - 2015-11-17 07:41:52,057 DEBUG : actual date: 1447774912 07:41:52 INFO - 2015-11-17 07:41:52,105 INFO : starting webserver on 'localhost:52295' 07:41:52 INFO - 2015-11-17 07:41:52,106 INFO : Starting test suite talos-linux64-ix-069 07:41:52 INFO - 2015-11-17 07:41:52,106 INFO : Starting test dromaeo_css 07:41:52 INFO - 2015-11-17 07:41:52,106 DEBUG : operating with platform_type : linux_ 07:41:52 INFO - 2015-11-17 07:41:52,107 INFO : Initialising browser for dromaeo_css test... 07:41:52 INFO - 2015-11-17 07:41:52,123 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzsmrYS/profile http://localhost:52295/getInfo.html 07:41:56 INFO - 2015-11-17 07:41:56,584 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:41:56 INFO - 2015-11-17 07:41:56,585 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:41:56 INFO - 2015-11-17 07:41:56,585 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:41:56 INFO - 2015-11-17 07:41:56,585 DEBUG : BROWSER_OUTPUT: __metrics 07:41:56 INFO - 2015-11-17 07:41:56,645 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:41:58 INFO - 2015-11-17 07:41:58,144 INFO : Browser initialized. 07:41:58 INFO - 2015-11-17 07:41:58,145 INFO : Running cycle 1/1 for dromaeo_css test... 07:41:58 INFO - 2015-11-17 07:41:58,145 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzsmrYS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:42:09 INFO - 2015-11-17 07:42:09,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 141807616 07:42:09 INFO - 2015-11-17 07:42:09,915 DEBUG : BROWSER_OUTPUT: 07:43:01 INFO - 2015-11-17 07:43:01,347 DEBUG : BROWSER_OUTPUT: 1447774981344 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] 07:45:09 INFO - 2015-11-17 07:45:09,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52295/tests/dromaeo/cssquery-ext.html) 07:45:11 INFO - 2015-11-17 07:45:11,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 265564160 07:45:11 INFO - 2015-11-17 07:45:11,267 DEBUG : BROWSER_OUTPUT: 07:48:13 INFO - 2015-11-17 07:48:13,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/dromaeo/cssquery-ext.html (next: http://localhost:52295/tests/dromaeo/cssquery-jquery.html) 07:48:14 INFO - 2015-11-17 07:48:14,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 226091008 07:48:14 INFO - 2015-11-17 07:48:14,283 DEBUG : BROWSER_OUTPUT: 07:51:16 INFO - 2015-11-17 07:51:16,077 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52295/tests/dromaeo/cssquery-mootools.html) 07:51:16 INFO - 2015-11-17 07:51:16,637 DEBUG : BROWSER_OUTPUT: RSS: Main: 214401024 07:51:16 INFO - 2015-11-17 07:51:16,638 DEBUG : BROWSER_OUTPUT: 07:54:18 INFO - 2015-11-17 07:54:18,466 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52295/tests/dromaeo/cssquery-prototype.html) 07:54:19 INFO - 2015-11-17 07:54:19,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 199651328 07:54:19 INFO - 2015-11-17 07:54:19,053 DEBUG : BROWSER_OUTPUT: 07:57:21 INFO - 2015-11-17 07:57:21,509 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52295/tests/dromaeo/cssquery-yui.html) 07:57:22 INFO - 2015-11-17 07:57:22,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 204361728 07:57:22 INFO - 2015-11-17 07:57:22,096 DEBUG : BROWSER_OUTPUT: 08:00:24 INFO - 2015-11-17 08:00:24,633 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/dromaeo/cssquery-yui.html (next: http://localhost:52295/tests/dromaeo/cssquery-dojo.html) 08:00:24 INFO - 2015-11-17 08:00:24,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 290226176 08:00:24 INFO - 2015-11-17 08:00:24,883 DEBUG : BROWSER_OUTPUT: 08:00:24 INFO - 2015-11-17 08:00:24,884 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:00:24 INFO - 2015-11-17 08:00:24,884 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:00:24 INFO - 2015-11-17 08:00:24,884 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:00:24 INFO - 2015-11-17 08:00:24,884 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:00:24 INFO - 2015-11-17 08:00:24,888 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3198.32835104628;3233.127055694964;3266.183454136466;3278.409886220481;3292.60488741351;5243.816466423676;5346.27825243593;5358.196270559418;5365.517103460687;5463.262459567957;5322.4411436799155;5332.280142180804;5352.545033672142;5362.383325917521;5416.214648875921;4793.257045158006;4861.392325959255;4962.206047032476;5016.272640467148;5021.196608542616;4795;4969.701817890938;5007.799688012494;5045.520675535819;5062.569681577071;4798.328234047236;4931.679440836334;4976.303317535548;5002.849914502534;5002.974985125087;4907.484714105039;4922.458529561745;4924.581410580105;4931.556159945622;4984.451710311862;4892.730899800509;4914.410270767495;4921.827736029258;4931.802727890916;4970.7017578945015;5114.309568208281;5182.041322355339;5195.9480405195845;5263.34208223972;5316.308879845596;5868.2664666916635;5892.911606325909;5896.911546326765;5903.350631430582;5939.3763654816485;5753;5961;5962.910556341659;5963.642181469126;5969.015112506475;5439.428859969686;5470.261514695545;5524.005678977783;5547.5007249347345;5594.468525490072;5927.229460170237;5940.881182376328;5969.3732158122775;5986.5809393342915;5991.310999235056;5763.049096899049;5776.971115144482;5780.421957804186;5780.624259423124;5787.739551720183;5803.912941305884;5831.300243970751;5868.031774757117;5929.347771745104;5963.910541341883;5888.087346461305;5893.941060589425;5894.941050589525;5909.852253693606;5949.077892926603;5703.771849125988;5864.589478736448;5897.351291357947;5899.498542623839;5907.4683278505145;4331.5018772840895;4401.713888597295;4415.072834704748;4429.734215947054;4524.389207457017;3977.622125898035;4057.797110144481;4064.4919385076864;4088.0597462583773;4114.033202197481;5471.37079235893;5629.437056294338;5670.234518340054;5671.2060311556415;5673.461021202979;5860.120981852671;5916.319623243296;5938.673372964442;5941.821745347646;5984.73068711909;5495.313085864267;5497.945020549823;5501.807436739695;5508.9724551376985;5571.303587051619;4971.776270067856;5040.873978150576;5042;5081.085404627129;5083.822066227738;5990.191324171268;5999.190109335271;6056.454919057306;6056.848578785478;6080.543959203077;5914.585978981602;5916.378780228014;5916.615419997686;5924.348321684525;5924.377940316204;5839.708014599168;5941.940580594139;6096;6096.512279017579;6096.634201947897;5817.9127313091185;5906.350301466749;5906.970465147819;5910.970445147746;5958.136070269873;5943;5957.702114894151;5961.642301461926;5965.642061476326;5972.761089556543;5665.773369065191;5667.943320566742;5787.363390027178;5812.9709351452975;5832.795852145155;5890.4698577128265;5895.351511333664;5896.764129434775;5902.1441890926435;5911.615744976562;5738.110592858114;5772.913406298825;5782.335031471434;5784.768609255582;5789;5693.202951586864;5731.656100633975;5789.363170051207;5802.47777700009;5930.258717660293;5732.283464566929;5751.597388182787;5760.567957403296;5764.394738552392;5783.334916484489 08:00:24 INFO - 2015-11-17 08:00:24,888 DEBUG : BROWSER_OUTPUT: |1;ext.html;551.8289330307603;591.7899145803242;597.8057131432284;600.7146605362456;605.1195510532176;29959.700402995964;36384.09039774007;36787.08032299194;37135.62864371356;37180.99999999996;42609.78695106528;42901.35647965275;42915.57084429155;42930.356044659275;42944;7667.693292268303;7786.4938778979185;8693.565321733904;8857.335699822506;8866.689665861697;10454.634087806928;10595.470226488684;10693.518791654355;10706.839397409045;10723.249372543925;10365.807932087831;10418.21863360251;10427.635032773855;10433.217508686841;10436.217283703752;7823.10034346049;8002.51984880909;8018.839623207561;10293;10488.423136727477;10232.079112879803;10363.06732394088;10376.896231037668;10377.792444151075;10388.688339349832;40787.38818917719;40849.59150408488;40974.79512602418;41302.173956521;41344;3110.5178697301953;3154.6056742907135;3490.703290220334;3597.316509863144;3962.346212874872;29924.401511969856;30411.543826842615;30560.69439305601;30788.538171927437;31651.20871978196;3458.706009989154;3480.286541259036;3598.4242521196743;3611.7832930024283;3639.9808053744996;289294;292267.53866230743;292328;292930.99999999785;293111;59543;60572;60762.39237607567;61352;61839.6908015466;71493;72611;72878.2712172882;72895.63552182312;72933.2706672937;15616.609584760472;15767.053976761432;15767.526974190792;15782;15798.289076991563;11803.170508571186;11810;11818.704532386588;11819.940900295443;11828.76342473163;20178;20213.696794548094;20509.794902051086;20559.691604625943;20581.38255852327;8057.194280572013;8233.217844304781;8302.128276530999;8319.126491718282;8325.8334833303;865.5326123893027;882.8057827277988;930.7952250504878;1043.1967385113421;1053.6628278950816;28606.570901436495;28699.42601148007;28857;29054.273643158667;32993.67006329954;1001.6594357918343;1012.711377257478;1012.7822518158631;1048.5072016152396;1054.393723608928;14589.635259118395;14699.92650036743;14966.625834354229;15145.621359466102;15235.61910952213;402400;407807;408477;408886;409102;54248.728756355966;54867;54968;54988.72505637446;55014;1283.1624774599707;1290.7160424706549;1299.6101169649066;1349.419749507721;1359.1029920252586;26622.600660989712;27429.45141097207;28503.572446412905;28704.282392940342;29670.851645742496;50346.74826625844;50961.490385095676;50965.745171273906;51046.48953510417;51068.23397649112;312005;313410;314500;314586;314949;28795;29167.416651667274;32127.518087228244;32541.674583253865;32766.34467310688;37707;40710.592894071866;42649;42661.573384267;43269.567304326556;35328.64671353356;35739.88991266038;35845.462318064725;36953.44569831401;37411.25177496489;35484.46773298351;35600.149012790265;35935.46096808602;36213.63786362103;36263.81868090748;34945.82527087348;35253.647463525034;35422.822885885405;35713.821430892676;35779;30542;31370.215744605655;32579.674203257666;32993.835030824695;33021;24590.877045615372;24927.37681557903;24960.001599936524;25335;25382.49235015326 08:00:24 INFO - 2015-11-17 08:00:24,888 DEBUG : BROWSER_OUTPUT: |2;jquery.html;345.6180920083306;350.9280597477517;351.17473936249814;351.90850378901496;353.9451385035319;16519.75220371694;17417.477475675732;18864.811351886477;19019;19040;17460.82539174608;17625.735613965768;17638.38265660702;17786.377476788315;18029;5322.946770532293;5359;5437.755301011444;5502.0921547944545;5505.476979686923;5456.045192091388;5493.560515158798;5497.8075767348155;5499.395066542677;5499.945000549983;3956.1494278730065;4060.614241647039;5352.197170424448;5445.700486473243;5456.427075157111;5778.075507918734;5937.67342796146;5947.524198064166;5979.46184843364;5985.970070149665;5142.948570514284;5234.607404444682;5236.581073514109;5238.5023422774775;5243.632945693803;15797.68404631901;16558.420455284006;19443.125059372363;20588.176472941213;21354.572908541897;2288.9542209155725;2306.6194077977116;2385.8091352691918;2541.1741184115235;2685.2883985743792;13138.211707297593;13266.66833329165;13498.59504214875;13543.661408464768;13706.040577159603;1658.4444211189266;1751.95620109497;1800.522861441719;1859.386402487176;1939.1273926732886;59483.70258148725;59811.70094149545;61450.38549614491;61721.07418388773;61932.69033654803;9544.761380965392;9707.66023189185;9915.603375865028;9933;9987.80024399508;12927.5475358362;12952.676183095498;12955.352232388343;12972.545960891324;12976.221426714428;7124.821879453055;7216.603086830275;7226.819329516699;7376.557406555624;7428.071491063617;6646.6676666166495;6676.998450232504;6730.091437655854;7072.080629518233;7175.856482870313;5900.557458190653;5975.910361344583;5986.850328741816;6012.579119461683;6027.427394397525;1657.4861792844256;1708.5557754983793;1713.6915355235928;1714.8285171483;1717.3216579451048;930.7021753038963;974.7806743482802;977.8142152990908;1000.8798944126606;1035.6841163445072;14594.781078283835;17460.738088928676;17505.212265448085;17836.55408614769;18016.36942706999;503.3582182716992;507.7613521644821;511.6571896829133;532.5647380310028;918.9770255743659;6309.779157729549;6334.398232167937;6338.556301058881;6418.903716444257;6469.51478639104;535552;574736;620271;634520;635453;77587.61206193933;77907.61046194845;80877.59561202156;81062;81562;511.29186077282486;516.8216965147018;518.5618152660995;520.2404489445452;521.7991073436755;10974;11115.38672970145;11294.887051129712;11383.829242561202;11386.487608057823;35975.640243598275;36074.45888311625;36747.47997928128;36978.07554811151;37266.06834829151;44508.55491445044;44707.55292447164;46227;48982.265266020324;49117.75441122914;6576.079348891063;6741.898871517029;6789.388954994074;6808.7276508939085;6827.692753826189;11955;12026.699332516757;12164.209326393757;12291.75416491683;12297.877021229673;10574.788504230026;10673.8932610676;10872.945635271773;10880.945595271973;10886.183536234656;10254.487275636338;10589.788204236027;10627.09669678086;10691.251612387057;10847.40339281347;10393.532291047073;10417.374957502574;10603;10810;11040.061594764535;6684.43182329488;6764.086848275617;6765.695543700644;6769.255381908085;6773.729050838108;8222.588870556328;10524.631637892637;10765;10954.561817527529;10969.067629251284 08:00:24 INFO - 2015-11-17 08:00:24,889 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1218.3177420644445;1677.3374517065758;1699.9320027198912;1708.957535903099;1730.3857130718586;7058.717651293949;7376.373008294295;7467.029286192801;7470.626468676558;7471.626418679065;7601.049868766404;7721.343685786715;7724.96137519313;7733.11069227039;7738.767836964886;2213.236433430464;2233.7207849018873;2234.854734442264;2237.7650346713604;2238.440389902524;2079.3969748772915;2108.641530939744;2121.2575598540543;2122.0981083039646;2123.596516661837;2208.293346129239;2217.2793842001333;2218.7226596675414;2230.208276061999;2298.9655155172604;2254.6730724045087;2274.5678321119017;2285.69143165673;2285.988570057156;2286.325533967484;2270.9545809083893;2284.920027799036;2284.977150228493;2285.931422057341;2286.8056215221727;6900.689468973908;7018.894716579255;7715;7739.651715672809;7765.1458339582605;4639.605633521155;4743.905121897543;4752.334673145762;4757.357756702835;4760.024195040009;3120.578721872541;3122.8438578071004;3129.092563156682;3166.9683303166903;3220.066180807563;995.512199022481;1019.755258737905;1029.3772267778036;1032.6953548703075;1060.0512541275593;10845;10879;10913.618023369145;10931.617393391272;10939.83590246139;4322.15717935006;4367.825286988548;4403.933940990888;4425.756583387944;4436.6007059364165;9387.57755900986;9410.294227932796;9411.576479058458;9446.763830904283;9467.384619999679;4836.516348365206;4841.661083724176;4844.660873738875;4844.781984810692;4857.465678775332;4386.978065109718;4393.143337049245;4394.2969124939855;4397.340398940185;4398.010447649317;3658.2866341063236;3713.7400381973544;3715.8327875245677;3733.4586484959527;3754.3617585010616;1223.559518573313;1232.0697873105748;1235.2897084176454;1237.2638280223252;1241;950.6625148072472;963.7446076789516;964.1178321835582;987.3138168972639;1100.9724756881142;7124.8575028499135;7158.785236442915;7200.891986620205;7204.531705439234;7210.026646402774;447.0388664371627;448.41705782482643;451.6589974569245;456.1492815898326;456.63697360598405;5329.733513324319;5367.490088441592;5370.087085195526;5616.634918730269;5705.914411283834;9229.815403692022;9416.293777966679;9542.3320367575;9546.331756777097;9558.713238602853;9223;9282;9295.90704092964;9578.425294482353;9588.472634005197;7343.77968660941;7387.335139837333;7393.852122957511;7439.25607439241;7483.962580187064;7048.788536343918;7139.750108746169;7177.569345839266;7178.5692858428665;7194.532355396883;8277.048139463797;8322.833543328978;8371.330293576377;8424.326053915795;8481.236688698047;8441.198086181803;8490.363222758195;8633.870491942751;8656.826863462822;8812.911870881466;6946.097007389007;6994.090768200102;6997.265287144776;7026.262242464672;7031.226565077735;7416.96291518539;7596.126445458622;7660.387169026353;7664.233576642514;7679.116901556169;7055.894161587477;7126.572405655677;7166.247544007804;7221.494495385273;7279.381252593589;6976.372126508639;6982.162140543167;7000.929990700028;7024.824379390556;7052.153741551047;6910.101686780888;6922.20394654601;6950.061741665013;6951.478639102189;6951.548149370275;6266.655333956676;6443.323451037573;6455.806325810233;6460.192475940507;6463.806085817245;6530.444912182517;6545.14913061299;6549.279579246374;6554.901676474761;6556.18047744032 08:00:24 INFO - 2015-11-17 08:00:24,890 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.6922001048978;316.6643358040477;319.3453420487999;320.51602080857907;322.79663811798565;5944.5541584381235;6047.092936059593;6077.878442431154;6080.05759107338;6126.326104128542;5857.7364018619155;6013.248343957005;6063.909041364372;6069.393060693928;6075.51395888329;4410.867673969786;4506.211413002711;4592.127495775792;4596.218642830727;4600.585947264745;4531.071130418273;4612.930806037895;4635;4649;4651.186042442576;4595.333676616889;4597.42532183477;4601.401817763686;4604.7927843247135;4607.35497030416;4593.586577208034;4605.332226827108;4608.032313214229;4610.67725259232;4614.700044497131;3953.2291203215386;4042.6967977401814;4046.898827529306;4048.068944142834;4051.412545180962;5726.112452569859;5736.942630573724;5744.798932037401;5758.107493338539;5775.942240577582;5377.0052540279785;5381.865453363658;5388.649737767072;5390.811321603725;5396.271503347037;6126;6256.405641464054;6260.248770147566;6371.649559274238;6417.06952491886;4446.644268458515;4461.5092339842595;4470.307102399101;4470.418845550058;4476.776161191928;6600.570962887397;6681.565698229648;6682.532222744361;6685.164354455693;6686.632235227061;4488.685791994529;4615;4624.190766615829;4626.606738427204;4628.814847406066;4653.069386122789;4688.179568575486;4691.437027556715;4691.53084691535;4695.389599352063;5342.893142137135;5386.48828361305;5394.62237643369;5397.541208997279;5401.054815407288;6478.222613286436;6501.902471462932;6512.804615861532;6513.967430162819;6516.934830651728;1629.2586872973006;1631.2659303313555;1660.1201363277482;1660.9584760380847;1672.916354182286;1103.7130346110068;1111.6109361723493;1133.3539882267194;1137.4881303413497;1138.8918052784973;6199.535034872402;6209.9379006210265;6214.658193799384;6215.844603884939;6216.129741836146;6661.26726060133;6680.966595166993;6687.264400915896;6703.262641109474;6708.2956289589865;6067.24159480065;6221.3156552780065;6221.906671399933;6222.066689996446;6225.844353891099;3589.6410358963894;3623.2934577757082;3623.5108260385036;3625.7643253188457;3625.8912232633065;6900.2409734929115;6912.723491060402;6927.064846245793;6927.203371612329;6932.549384290005;6621.039949207338;6763.188417389944;6765.763198288135;6766;6778.152730908637;6660.8667826643195;6778.423833974168;6905.378515933489;6925.411340036053;6929.445644348541;6564.4420224281475;6691.665416729242;6717;6733.192016957996;6769.458443324621;6694.966525167343;6697.397234248941;6698.497612679166;6705.698243578953;6710.798676039727;6843.931560684329;7016.5790052597;7017.614031228127;7019.08751862275;7024.121984751906;4633.235516139934;4636.350910872548;4637.188492013816;4637.791299391603;4638.652101092364;6751.898721519083;6755.729770809309;6760.459163266829;6760.797176084725;6761.594304341756;6407.167068281094;6537.1501704778075;6539.4768418525455;6563.442107420923;6570.704318305783;6508.479321654351;6553.377429144223;6557.377049180321;6557.770478033246;6565.606063636197;6423.293437721753;6435.06691529735;6436.613803171825;6439.710213040518;6450.967745161244;6489.156409666713;6548.410643042149;6595.274519802914;6611.66941652925;6621.437177839937;6440.613563186036;6441.355864413521;6446.548741588043;6450.0969864218105;6454.935450645434 08:00:24 INFO - 2015-11-17 08:00:24,892 DEBUG : BROWSER_OUTPUT: |5;yui.html;631.3844002097956;672.579637726421;733.666181887241;796.2435686098208;805.4643661964793;12652;12788.48846046157;12964.416601252931;12967.546135885246;13087.21476711398;12543.121981461301;12597.055220858427;12685.238885666844;12687.492500299977;12701.682457938534;692.5325405351367;703.9612821294827;817.4196320612342;819.8729196974449;834.4659417972503;837.2966707965307;837.5351679817699;838.4172999765166;844.8986121665378;845.1084106267884;858.2704701004159;862.6420035685184;863.7581477186397;863.8445079885649;864.3992425264444;710.4919982212717;719.1118968074423;850.4854562989395;867.5835598912495;867.6659486097834;637.5154882289447;640.8718256348702;640.9070684750685;641.3169973977746;641.720851429625;12671.809922851164;12749.42627581761;12794.744105117845;12833.550825721148;12839.871601283961;12004.459799309052;12064.879351206464;12422.689432764162;12442.75114497705;12563.811542826865;9942.652007179786;9989.150922171624;10084.697459076166;10170.847437288447;10280.948595256976;3557;3585.928281434383;3586.8027258500774;3608.765430247052;3735.570409402926;47760.52239477595;47865.04269914617;47911.76044119757;48058.75970620124;48089;9380.437173769596;9387.389819661701;9434.103760142776;9444.8583271251;9544.33189676716;18298;18347.082645867653;18544;18572.164252608665;18598;6890.10428644273;6928.099347084847;6984.196817365966;7055.506114572034;7086.645667716697;4203.306454434984;4343.565643435694;4372.300431930939;4385.276429389179;4452.065066336106;2725.822821516595;2738.151173136334;2750.8624568771484;2752.8210666306627;2758.7792976561827;427.84383699949296;584.2113147251177;594.9970250148722;598.5540772124795;598.931122920861;574.178924138486;582.909649004405;600.504583718434;634.501915995941;637.1175921348965;8215.488215488193;8217.95891020541;8407.285380742705;8532.658693652184;9461.810763784686;506.9974650126726;607.2743072028883;620.3393386043849;637.7895294552786;644.8484606117559;3627.818609069536;4036.4257939403656;4454.354118652777;4527.683062185615;4542.88642783933;53680.46319536755;54351.18473222905;54710.72644636752;54885;54979.725101375036;47653.76173119112;47782.76108619435;48125.75937120292;48252;50604.74697626488;43158.35262471066;44249.33625995613;44295.557044429144;44916;47324;8732.69435569752;8862.601182946912;8865.51239681798;8920.86618700707;9271.119243671841;35717.28565428729;36525.26949461049;36641.63358366489;36647.63352366549;36837.26325473529;45928;45958.54041459542;46122;46612.53387466082;47454;7859.253370929752;8166.510009399455;8416.2004609562;8722.215000649972;8811.471311721318;12675.93662031684;12768.61694149177;12784.360781960679;12836.614901552968;13465.326733663474;10927.890721092688;11613.883861161617;12032.75934481288;12454.564090256797;12493.500259989862;11834.822477663014;12163.635090947286;12279.017678585513;12679.366031698193;12685.365731713193;11272.436378181223;11274.299350020388;11336.546538138382;11390.658280251606;11752.236104653512;8851.513166775889;8943.552822358986;9176.816463670822;9374.269500300969;9391.953040234755;8904.421212621159;9104.271658267191;9154.267658587163;9325.720228393158;9493.572789224363 08:00:24 INFO - 2015-11-17 08:00:24,892 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:00:24 INFO - 2015-11-17 08:00:24,892 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:00:24 INFO - 2015-11-17 08:00:24,892 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1091 08:00:24 INFO - 2015-11-17 08:00:24,892 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:00:24 INFO - 2015-11-17 08:00:24,892 DEBUG : BROWSER_OUTPUT: __startTimestamp1447776024883__endTimestamp 08:00:24 INFO - 2015-11-17 08:00:24,892 DEBUG : BROWSER_OUTPUT: 08:00:24 INFO - 2015-11-17 08:00:24,892 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:00:24 INFO - 2015-11-17 08:00:24,893 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:00:24 INFO - 2015-11-17 08:00:24,893 DEBUG : BROWSER_OUTPUT: 08:00:24 INFO - 2015-11-17 08:00:24,893 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5454.70 Median:5751.60 stddev:630.02 (11.0%) stddev-sans-first:606.58 08:00:24 INFO - 2015-11-17 08:00:24,893 DEBUG : BROWSER_OUTPUT: Values: 3198.3 3233.1 3266.2 3278.4 3292.6 5243.8 5346.3 5358.2 5365.5 5463.3 5322.4 5332.3 5352.5 5362.4 5416.2 4793.3 4861.4 4962.2 5016.3 5021.2 4795.0 4969.7 5007.8 5045.5 5062.6 4798.3 4931.7 4976.3 5002.8 5003.0 4907.5 4922.5 4924.6 4931.6 4984.5 4892.7 4914.4 4921.8 4931.8 4970.7 5114.3 5182.0 5195.9 5263.3 5316.3 5868.3 5892.9 5896.9 5903.4 5939.4 5753.0 5961.0 5962.9 5963.6 5969.0 5439.4 5470.3 5524.0 5547.5 5594.5 5927.2 5940.9 5969.4 5986.6 5991.3 5763.0 5777.0 5780.4 5780.6 5787.7 5803.9 5831.3 5868.0 5929.3 5963.9 5888.1 5893.9 5894.9 5909.9 5949.1 5703.8 5864.6 5897.4 5899.5 5907.5 4331.5 4401.7 4415.1 4429.7 4524.4 3977.6 4057.8 4064.5 4088.1 4114.0 5471.4 5629.4 5670.2 5671.2 5673.5 5860.1 5916.3 5938.7 5941.8 5984.7 5495.3 5497.9 5501.8 5509.0 5571.3 4971.8 5040.9 5042.0 5081.1 5083.8 5990.2 5999.2 6056.5 6056.8 6080.5 5914.6 5916.4 5916.6 5924.3 5924.4 5839.7 5941.9 6096.0 6096.5 6096.6 5817.9 5906.4 5907.0 5911.0 5958.1 5943.0 5957.7 5961.6 5965.6 5972.8 5665.8 5667.9 5787.4 5813.0 5832.8 5890.5 5895.4 5896.8 5902.1 5911.6 5738.1 5772.9 5782.3 5784.8 5789.0 5693.2 5731.7 5789.4 5802.5 5930.3 5732.3 5751.6 5760.6 5764.4 5783.3 08:00:24 INFO - 2015-11-17 08:00:24,893 DEBUG : BROWSER_OUTPUT: 08:00:24 INFO - 2015-11-17 08:00:24,893 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50781.35 Median:33007.42 stddev:89793.79 (272.0%) stddev-sans-first:89966.49 08:00:24 INFO - 2015-11-17 08:00:24,893 DEBUG : BROWSER_OUTPUT: Values: 551.8 591.8 597.8 600.7 605.1 29959.7 36384.1 36787.1 37135.6 37181.0 42609.8 42901.4 42915.6 42930.4 42944.0 7667.7 7786.5 8693.6 8857.3 8866.7 10454.6 10595.5 10693.5 10706.8 10723.2 10365.8 10418.2 10427.6 10433.2 10436.2 7823.1 8002.5 8018.8 10293.0 10488.4 10232.1 10363.1 10376.9 10377.8 10388.7 40787.4 40849.6 40974.8 41302.2 41344.0 3110.5 3154.6 3490.7 3597.3 3962.3 29924.4 30411.5 30560.7 30788.5 31651.2 3458.7 3480.3 3598.4 3611.8 3640.0 289294.0 292267.5 292328.0 292931.0 293111.0 59543.0 60572.0 60762.4 61352.0 61839.7 71493.0 72611.0 72878.3 72895.6 72933.3 15616.6 15767.1 15767.5 15782.0 15798.3 11803.2 11810.0 11818.7 11819.9 11828.8 20178.0 20213.7 20509.8 20559.7 20581.4 8057.2 8233.2 8302.1 8319.1 8325.8 865.5 882.8 930.8 1043.2 1053.7 28606.6 28699.4 28857.0 29054.3 32993.7 1001.7 1012.7 1012.8 1048.5 1054.4 14589.6 14699.9 14966.6 15145.6 15235.6 402400.0 407807.0 408477.0 408886.0 409102.0 54248.7 54867.0 54968.0 54988.7 55014.0 1283.2 1290.7 1299.6 1349.4 1359.1 26622.6 27429.5 28503.6 28704.3 29670.9 50346.7 50961.5 50965.7 51046.5 51068.2 312005.0 313410.0 314500.0 314586.0 314949.0 28795.0 29167.4 32127.5 32541.7 32766.3 37707.0 40710.6 42649.0 42661.6 43269.6 35328.6 35739.9 35845.5 36953.4 37411.3 35484.5 35600.1 35935.5 36213.6 36263.8 34945.8 35253.6 35422.8 35713.8 35779.0 30542.0 31370.2 32579.7 32993.8 33021.0 24590.9 24927.4 24960.0 25335.0 25382.5 08:00:24 INFO - 2015-11-17 08:00:24,893 DEBUG : BROWSER_OUTPUT: 08:00:24 INFO - 2015-11-17 08:00:24,894 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29805.95 Median:47604.63 stddev:98333.84 (206.6%) stddev-sans-first:98584.81 08:00:24 INFO - 2015-11-17 08:00:24,894 DEBUG : BROWSER_OUTPUT: Values: 345.6 350.9 351.2 351.9 353.9 16519.8 17417.5 18864.8 19019.0 19040.0 17460.8 17625.7 17638.4 17786.4 18029.0 5322.9 5359.0 5437.8 5502.1 5505.5 5456.0 5493.6 5497.8 5499.4 5499.9 3956.1 4060.6 5352.2 5445.7 5456.4 5778.1 5937.7 5947.5 5979.5 5986.0 5142.9 5234.6 5236.6 5238.5 5243.6 15797.7 16558.4 19443.1 20588.2 21354.6 2289.0 2306.6 2385.8 2541.2 2685.3 13138.2 13266.7 13498.6 13543.7 13706.0 1658.4 1752.0 1800.5 1859.4 1939.1 59483.7 59811.7 61450.4 61721.1 61932.7 9544.8 9707.7 9915.6 9933.0 9987.8 12927.5 12952.7 12955.4 12972.5 12976.2 7124.8 7216.6 7226.8 7376.6 7428.1 6646.7 6677.0 6730.1 7072.1 7175.9 5900.6 5975.9 5986.9 6012.6 6027.4 1657.5 1708.6 1713.7 1714.8 1717.3 930.7 974.8 977.8 1000.9 1035.7 14594.8 17460.7 17505.2 17836.6 18016.4 503.4 507.8 511.7 532.6 919.0 6309.8 6334.4 6338.6 6418.9 6469.5 535552.0 574736.0 620271.0 634520.0 635453.0 77587.6 77907.6 80877.6 81062.0 81562.0 511.3 516.8 518.6 520.2 521.8 10974.0 11115.4 11294.9 11383.8 11386.5 35975.6 36074.5 36747.5 36978.1 37266.1 44508.6 44707.6 46227.0 48982.3 49117.8 6576.1 6741.9 6789.4 6808.7 6827.7 11955.0 12026.7 12164.2 12291.8 12297.9 10574.8 10673.9 10872.9 10880.9 10886.2 10254.5 10589.8 10627.1 10691.3 10847.4 10393.5 10417.4 10603.0 10810.0 11040.1 6684.4 6764.1 6765.7 6769.3 6773.7 8222.6 10524.6 10765.0 10954.6 10969.1 08:00:24 INFO - 2015-11-17 08:00:24,894 DEBUG : BROWSER_OUTPUT: 08:00:24 INFO - 2015-11-17 08:00:24,895 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5451.05 Median:6537.80 stddev:2872.86 (43.9%) stddev-sans-first:2863.30 08:00:24 INFO - 2015-11-17 08:00:24,896 DEBUG : BROWSER_OUTPUT: Values: 1218.3 1677.3 1699.9 1709.0 1730.4 7058.7 7376.4 7467.0 7470.6 7471.6 7601.0 7721.3 7725.0 7733.1 7738.8 2213.2 2233.7 2234.9 2237.8 2238.4 2079.4 2108.6 2121.3 2122.1 2123.6 2208.3 2217.3 2218.7 2230.2 2299.0 2254.7 2274.6 2285.7 2286.0 2286.3 2271.0 2284.9 2285.0 2285.9 2286.8 6900.7 7018.9 7715.0 7739.7 7765.1 4639.6 4743.9 4752.3 4757.4 4760.0 3120.6 3122.8 3129.1 3167.0 3220.1 995.5 1019.8 1029.4 1032.7 1060.1 10845.0 10879.0 10913.6 10931.6 10939.8 4322.2 4367.8 4403.9 4425.8 4436.6 9387.6 9410.3 9411.6 9446.8 9467.4 4836.5 4841.7 4844.7 4844.8 4857.5 4387.0 4393.1 4394.3 4397.3 4398.0 3658.3 3713.7 3715.8 3733.5 3754.4 1223.6 1232.1 1235.3 1237.3 1241.0 950.7 963.7 964.1 987.3 1101.0 7124.9 7158.8 7200.9 7204.5 7210.0 447.0 448.4 451.7 456.1 456.6 5329.7 5367.5 5370.1 5616.6 5705.9 9229.8 9416.3 9542.3 9546.3 9558.7 9223.0 9282.0 9295.9 9578.4 9588.5 7343.8 7387.3 7393.9 7439.3 7484.0 7048.8 7139.8 7177.6 7178.6 7194.5 8277.0 8322.8 8371.3 8424.3 8481.2 8441.2 8490.4 8633.9 8656.8 8812.9 6946.1 6994.1 6997.3 7026.3 7031.2 7417.0 7596.1 7660.4 7664.2 7679.1 7055.9 7126.6 7166.2 7221.5 7279.4 6976.4 6982.2 7000.9 7024.8 7052.2 6910.1 6922.2 6950.1 6951.5 6951.5 6266.7 6443.3 6455.8 6460.2 6463.8 6530.4 6545.1 6549.3 6554.9 6556.2 08:00:24 INFO - 2015-11-17 08:00:24,896 DEBUG : BROWSER_OUTPUT: 08:00:24 INFO - 2015-11-17 08:00:24,897 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5410.98 Median:6126.16 stddev:1637.76 (26.7%) stddev-sans-first:1597.08 08:00:24 INFO - 2015-11-17 08:00:24,898 DEBUG : BROWSER_OUTPUT: Values: 315.7 316.7 319.3 320.5 322.8 5944.6 6047.1 6077.9 6080.1 6126.3 5857.7 6013.2 6063.9 6069.4 6075.5 4410.9 4506.2 4592.1 4596.2 4600.6 4531.1 4612.9 4635.0 4649.0 4651.2 4595.3 4597.4 4601.4 4604.8 4607.4 4593.6 4605.3 4608.0 4610.7 4614.7 3953.2 4042.7 4046.9 4048.1 4051.4 5726.1 5736.9 5744.8 5758.1 5775.9 5377.0 5381.9 5388.6 5390.8 5396.3 6126.0 6256.4 6260.2 6371.6 6417.1 4446.6 4461.5 4470.3 4470.4 4476.8 6600.6 6681.6 6682.5 6685.2 6686.6 4488.7 4615.0 4624.2 4626.6 4628.8 4653.1 4688.2 4691.4 4691.5 4695.4 5342.9 5386.5 5394.6 5397.5 5401.1 6478.2 6501.9 6512.8 6514.0 6516.9 1629.3 1631.3 1660.1 1661.0 1672.9 1103.7 1111.6 1133.4 1137.5 1138.9 6199.5 6209.9 6214.7 6215.8 6216.1 6661.3 6681.0 6687.3 6703.3 6708.3 6067.2 6221.3 6221.9 6222.1 6225.8 3589.6 3623.3 3623.5 3625.8 3625.9 6900.2 6912.7 6927.1 6927.2 6932.5 6621.0 6763.2 6765.8 6766.0 6778.2 6660.9 6778.4 6905.4 6925.4 6929.4 6564.4 6691.7 6717.0 6733.2 6769.5 6695.0 6697.4 6698.5 6705.7 6710.8 6843.9 7016.6 7017.6 7019.1 7024.1 4633.2 4636.4 4637.2 4637.8 4638.7 6751.9 6755.7 6760.5 6760.8 6761.6 6407.2 6537.2 6539.5 6563.4 6570.7 6508.5 6553.4 6557.4 6557.8 6565.6 6423.3 6435.1 6436.6 6439.7 6451.0 6489.2 6548.4 6595.3 6611.7 6621.4 6440.6 6441.4 6446.5 6450.1 6454.9 08:00:24 INFO - 2015-11-17 08:00:24,898 DEBUG : BROWSER_OUTPUT: 08:00:24 INFO - 2015-11-17 08:00:24,898 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13565.94 Median:48107.38 stddev:15640.73 (32.5%) stddev-sans-first:15654.45 08:00:24 INFO - 2015-11-17 08:00:24,899 DEBUG : BROWSER_OUTPUT: Values: 631.4 672.6 733.7 796.2 805.5 12652.0 12788.5 12964.4 12967.5 13087.2 12543.1 12597.1 12685.2 12687.5 12701.7 692.5 704.0 817.4 819.9 834.5 837.3 837.5 838.4 844.9 845.1 858.3 862.6 863.8 863.8 864.4 710.5 719.1 850.5 867.6 867.7 637.5 640.9 640.9 641.3 641.7 12671.8 12749.4 12794.7 12833.6 12839.9 12004.5 12064.9 12422.7 12442.8 12563.8 9942.7 9989.2 10084.7 10170.8 10280.9 3557.0 3585.9 3586.8 3608.8 3735.6 47760.5 47865.0 47911.8 48058.8 48089.0 9380.4 9387.4 9434.1 9444.9 9544.3 18298.0 18347.1 18544.0 18572.2 18598.0 6890.1 6928.1 6984.2 7055.5 7086.6 4203.3 4343.6 4372.3 4385.3 4452.1 2725.8 2738.2 2750.9 2752.8 2758.8 427.8 584.2 595.0 598.6 598.9 574.2 582.9 600.5 634.5 637.1 8215.5 8218.0 8407.3 8532.7 9461.8 507.0 607.3 620.3 637.8 644.8 3627.8 4036.4 4454.4 4527.7 4542.9 53680.5 54351.2 54710.7 54885.0 54979.7 47653.8 47782.8 48125.8 48252.0 50604.7 43158.4 44249.3 44295.6 44916.0 47324.0 8732.7 8862.6 8865.5 8920.9 9271.1 35717.3 36525.3 36641.6 36647.6 36837.3 45928.0 45958.5 46122.0 46612.5 47454.0 7859.3 8166.5 8416.2 8722.2 8811.5 12675.9 12768.6 12784.4 12836.6 13465.3 10927.9 11613.9 12032.8 12454.6 12493.5 11834.8 12163.6 12279.0 12679.4 12685.4 11272.4 11274.3 11336.5 11390.7 11752.2 8851.5 8943.6 9176.8 9374.3 9392.0 8904.4 9104.3 9154.3 9325.7 9493.6 08:00:24 INFO - 2015-11-17 08:00:24,899 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:00:24 INFO - 2015-11-17 08:00:24,899 DEBUG : BROWSER_OUTPUT: 08:00:25 INFO - 2015-11-17 08:00:25,647 INFO : Browser exited with error code: 0 08:00:25 INFO - 2015-11-17 08:00:25,663 INFO : Completed test dromaeo_css (00:18:33) 08:00:25 INFO - 2015-11-17 08:00:25,663 INFO : Starting test kraken 08:00:25 INFO - 2015-11-17 08:00:25,663 DEBUG : operating with platform_type : linux_ 08:00:25 INFO - 2015-11-17 08:00:25,663 INFO : Initialising browser for kraken test... 08:00:25 INFO - 2015-11-17 08:00:25,669 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyHPUGg/profile http://localhost:52295/getInfo.html 08:00:29 INFO - 2015-11-17 08:00:29,629 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:00:29 INFO - 2015-11-17 08:00:29,630 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:00:29 INFO - 2015-11-17 08:00:29,630 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:00:29 INFO - 2015-11-17 08:00:29,630 DEBUG : BROWSER_OUTPUT: __metrics 08:00:29 INFO - 2015-11-17 08:00:29,712 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:00:31 INFO - 2015-11-17 08:00:31,240 INFO : Browser initialized. 08:00:31 INFO - 2015-11-17 08:00:31,240 INFO : Running cycle 1/1 for kraken test... 08:00:31 INFO - 2015-11-17 08:00:31,240 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyHPUGg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:00:43 INFO - 2015-11-17 08:00:43,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 142401536 08:00:43 INFO - 2015-11-17 08:00:43,062 DEBUG : BROWSER_OUTPUT: 08:00:45 INFO - 2015-11-17 08:00:45,537 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52295/tests/kraken/driver.html?testName=audio-beat-detection) 08:00:46 INFO - 2015-11-17 08:00:46,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 181256192 08:00:46 INFO - 2015-11-17 08:00:46,111 DEBUG : BROWSER_OUTPUT: 08:00:48 INFO - 2015-11-17 08:00:48,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52295/tests/kraken/driver.html?testName=audio-dft) 08:00:49 INFO - 2015-11-17 08:00:49,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 167616512 08:00:49 INFO - 2015-11-17 08:00:49,271 DEBUG : BROWSER_OUTPUT: 08:00:52 INFO - 2015-11-17 08:00:52,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52295/tests/kraken/driver.html?testName=audio-fft) 08:00:52 INFO - 2015-11-17 08:00:52,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 152395776 08:00:52 INFO - 2015-11-17 08:00:52,772 DEBUG : BROWSER_OUTPUT: 08:00:54 INFO - 2015-11-17 08:00:54,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52295/tests/kraken/driver.html?testName=audio-oscillator) 08:00:55 INFO - 2015-11-17 08:00:55,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 153051136 08:00:55 INFO - 2015-11-17 08:00:55,326 DEBUG : BROWSER_OUTPUT: 08:00:57 INFO - 2015-11-17 08:00:57,471 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52295/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:00:58 INFO - 2015-11-17 08:00:58,031 DEBUG : BROWSER_OUTPUT: RSS: Main: 154464256 08:00:58 INFO - 2015-11-17 08:00:58,032 DEBUG : BROWSER_OUTPUT: 08:01:00 INFO - 2015-11-17 08:01:00,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52295/tests/kraken/driver.html?testName=imaging-darkroom) 08:01:01 INFO - 2015-11-17 08:01:01,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 156819456 08:01:01 INFO - 2015-11-17 08:01:01,496 DEBUG : BROWSER_OUTPUT: 08:01:04 INFO - 2015-11-17 08:01:04,932 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52295/tests/kraken/driver.html?testName=imaging-desaturate) 08:01:05 INFO - 2015-11-17 08:01:05,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 157302784 08:01:05 INFO - 2015-11-17 08:01:05,501 DEBUG : BROWSER_OUTPUT: 08:01:08 INFO - 2015-11-17 08:01:08,219 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52295/tests/kraken/driver.html?testName=json-parse-financial) 08:01:08 INFO - 2015-11-17 08:01:08,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 156303360 08:01:08 INFO - 2015-11-17 08:01:08,785 DEBUG : BROWSER_OUTPUT: 08:01:10 INFO - 2015-11-17 08:01:10,353 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52295/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:01:10 INFO - 2015-11-17 08:01:10,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 167768064 08:01:10 INFO - 2015-11-17 08:01:10,920 DEBUG : BROWSER_OUTPUT: 08:01:12 INFO - 2015-11-17 08:01:12,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52295/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:01:13 INFO - 2015-11-17 08:01:13,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 168001536 08:01:13 INFO - 2015-11-17 08:01:13,322 DEBUG : BROWSER_OUTPUT: 08:01:15 INFO - 2015-11-17 08:01:15,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52295/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:01:15 INFO - 2015-11-17 08:01:15,979 DEBUG : BROWSER_OUTPUT: RSS: Main: 174080000 08:01:15 INFO - 2015-11-17 08:01:15,980 DEBUG : BROWSER_OUTPUT: 08:01:18 INFO - 2015-11-17 08:01:18,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:01:18 INFO - 2015-11-17 08:01:18,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 182546432 08:01:18 INFO - 2015-11-17 08:01:18,940 DEBUG : BROWSER_OUTPUT: 08:01:21 INFO - 2015-11-17 08:01:21,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:01:22 INFO - 2015-11-17 08:01:22,064 DEBUG : BROWSER_OUTPUT: RSS: Main: 181207040 08:01:22 INFO - 2015-11-17 08:01:22,064 DEBUG : BROWSER_OUTPUT: 08:01:23 INFO - 2015-11-17 08:01:23,701 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52295/tests/kraken/driver.html?testName=ai-astar) 08:01:23 INFO - 2015-11-17 08:01:23,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 241106944 08:01:23 INFO - 2015-11-17 08:01:23,951 DEBUG : BROWSER_OUTPUT: 08:01:23 INFO - 2015-11-17 08:01:23,955 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:01:23 INFO - 2015-11-17 08:01:23,955 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:01:23 INFO - 2015-11-17 08:01:23,955 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:01:23 INFO - 2015-11-17 08:01:23,955 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:01:23 INFO - 2015-11-17 08:01:23,956 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;110;105;110;111;110;100;110;110;109 08:01:23 INFO - 2015-11-17 08:01:23,956 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;123;150;167;129;147;153;125;169;123 08:01:23 INFO - 2015-11-17 08:01:23,956 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;162;160;160;163;160;166;161;163 08:01:23 INFO - 2015-11-17 08:01:23,956 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;72;85;95;73;72;73;99;90;71 08:01:23 INFO - 2015-11-17 08:01:23,956 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;89;136;90;91;91;135;90;91;132 08:01:23 INFO - 2015-11-17 08:01:23,956 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;110;110;109;110;110;109 08:01:23 INFO - 2015-11-17 08:01:23,957 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;144;145;146;146;145;146;145;145;145 08:01:23 INFO - 2015-11-17 08:01:23,957 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;95;95;96;95;95;95;95 08:01:23 INFO - 2015-11-17 08:01:23,957 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;59;60;58;60;60;68;57;56 08:01:23 INFO - 2015-11-17 08:01:23,957 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;68;68;68;69;69;68;68;68 08:01:23 INFO - 2015-11-17 08:01:23,957 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;92;85;85;86;85;85;96;86 08:01:23 INFO - 2015-11-17 08:01:23,957 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;122;122;113;116;127;123;120;129;123 08:01:23 INFO - 2015-11-17 08:01:23,957 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;151;140;154;151;154;141;151;149;146;143 08:01:23 INFO - 2015-11-17 08:01:23,958 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;66;66;67;65;68;68;67;67 08:01:23 INFO - 2015-11-17 08:01:23,958 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:01:23 INFO - 2015-11-17 08:01:23,958 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:01:23 INFO - 2015-11-17 08:01:23,958 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,905 08:01:23 INFO - 2015-11-17 08:01:23,958 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:01:23 INFO - 2015-11-17 08:01:23,958 DEBUG : BROWSER_OUTPUT: __startTimestamp1447776083953__endTimestamp 08:01:23 INFO - 2015-11-17 08:01:23,959 DEBUG : BROWSER_OUTPUT: 08:01:23 INFO - 2015-11-17 08:01:23,962 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:01:23 INFO - 2015-11-17 08:01:23,962 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:01:23 INFO - 2015-11-17 08:01:23,962 DEBUG : BROWSER_OUTPUT: 08:01:23 INFO - 2015-11-17 08:01:23,962 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.40 Median:110.00 stddev:3.37 (3.1%) stddev-sans-first:3.57 08:01:23 INFO - 2015-11-17 08:01:23,963 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 105.0 110.0 111.0 110.0 100.0 110.0 110.0 109.0 08:01:23 INFO - 2015-11-17 08:01:23,963 DEBUG : BROWSER_OUTPUT: 08:01:23 INFO - 2015-11-17 08:01:23,963 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.90 Median:151.50 stddev:17.73 (11.7%) stddev-sans-first:18.50 08:01:23 INFO - 2015-11-17 08:01:23,963 DEBUG : BROWSER_OUTPUT: Values: 153.0 123.0 150.0 167.0 129.0 147.0 153.0 125.0 169.0 123.0 08:01:23 INFO - 2015-11-17 08:01:23,963 DEBUG : BROWSER_OUTPUT: 08:01:23 INFO - 2015-11-17 08:01:23,963 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.87 (1.2%) stddev-sans-first:1.99 08:01:23 INFO - 2015-11-17 08:01:23,963 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 162.0 160.0 160.0 163.0 160.0 166.0 161.0 163.0 08:01:23 INFO - 2015-11-17 08:01:23,963 DEBUG : BROWSER_OUTPUT: 08:01:23 INFO - 2015-11-17 08:01:23,963 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:79.00 stddev:11.05 (14.0%) stddev-sans-first:11.22 08:01:23 INFO - 2015-11-17 08:01:23,964 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 85.0 95.0 73.0 72.0 73.0 99.0 90.0 71.0 08:01:23 INFO - 2015-11-17 08:01:23,964 DEBUG : BROWSER_OUTPUT: 08:01:23 INFO - 2015-11-17 08:01:23,964 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.50 Median:90.00 stddev:21.31 (23.7%) stddev-sans-first:22.03 08:01:23 INFO - 2015-11-17 08:01:23,964 DEBUG : BROWSER_OUTPUT: Values: 90.0 89.0 136.0 90.0 91.0 91.0 135.0 90.0 91.0 132.0 08:01:23 INFO - 2015-11-17 08:01:23,964 DEBUG : BROWSER_OUTPUT: 08:01:23 INFO - 2015-11-17 08:01:23,964 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 08:01:23 INFO - 2015-11-17 08:01:23,964 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 110.0 110.0 109.0 110.0 110.0 109.0 08:01:23 INFO - 2015-11-17 08:01:23,964 DEBUG : BROWSER_OUTPUT: 08:01:23 INFO - 2015-11-17 08:01:23,964 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 08:01:23 INFO - 2015-11-17 08:01:23,964 DEBUG : BROWSER_OUTPUT: Values: 145.0 144.0 145.0 146.0 146.0 145.0 146.0 145.0 145.0 145.0 08:01:23 INFO - 2015-11-17 08:01:23,964 DEBUG : BROWSER_OUTPUT: 08:01:23 INFO - 2015-11-17 08:01:23,965 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:01:23 INFO - 2015-11-17 08:01:23,965 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 08:01:23 INFO - 2015-11-17 08:01:23,965 DEBUG : BROWSER_OUTPUT: 08:01:23 INFO - 2015-11-17 08:01:23,965 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.60 Median:59.50 stddev:3.24 (5.4%) stddev-sans-first:3.43 08:01:23 INFO - 2015-11-17 08:01:23,965 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 59.0 60.0 58.0 60.0 60.0 68.0 57.0 56.0 08:01:23 INFO - 2015-11-17 08:01:23,965 DEBUG : BROWSER_OUTPUT: 08:01:23 INFO - 2015-11-17 08:01:23,965 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 08:01:23 INFO - 2015-11-17 08:01:23,965 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 68.0 68.0 68.0 69.0 69.0 68.0 68.0 68.0 08:01:23 INFO - 2015-11-17 08:01:23,965 DEBUG : BROWSER_OUTPUT: 08:01:23 INFO - 2015-11-17 08:01:23,965 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:85.50 stddev:3.97 (4.6%) stddev-sans-first:4.08 08:01:23 INFO - 2015-11-17 08:01:23,966 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 92.0 85.0 85.0 86.0 85.0 85.0 96.0 86.0 08:01:23 INFO - 2015-11-17 08:01:23,966 DEBUG : BROWSER_OUTPUT: 08:01:23 INFO - 2015-11-17 08:01:23,966 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:122.50 stddev:5.12 (4.2%) stddev-sans-first:4.95 08:01:23 INFO - 2015-11-17 08:01:23,966 DEBUG : BROWSER_OUTPUT: Values: 115.0 122.0 122.0 113.0 116.0 127.0 123.0 120.0 129.0 123.0 08:01:23 INFO - 2015-11-17 08:01:23,966 DEBUG : BROWSER_OUTPUT: 08:01:23 INFO - 2015-11-17 08:01:23,966 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:151.00 stddev:5.19 (3.4%) stddev-sans-first:5.39 08:01:23 INFO - 2015-11-17 08:01:23,966 DEBUG : BROWSER_OUTPUT: Values: 151.0 140.0 154.0 151.0 154.0 141.0 151.0 149.0 146.0 143.0 08:01:23 INFO - 2015-11-17 08:01:23,966 DEBUG : BROWSER_OUTPUT: 08:01:23 INFO - 2015-11-17 08:01:23,966 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 08:01:23 INFO - 2015-11-17 08:01:23,966 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 66.0 66.0 67.0 65.0 68.0 68.0 67.0 67.0 08:01:23 INFO - 2015-11-17 08:01:23,966 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:01:23 INFO - 2015-11-17 08:01:23,967 DEBUG : BROWSER_OUTPUT: 08:01:24 INFO - 2015-11-17 08:01:24,823 INFO : Browser exited with error code: 0 08:01:24 INFO - 2015-11-17 08:01:24,879 INFO : Completed test kraken (00:00:59) 08:01:24 INFO - 2015-11-17 08:01:24,879 INFO : Starting test v8_7 08:01:24 INFO - 2015-11-17 08:01:24,879 DEBUG : operating with platform_type : linux_ 08:01:24 INFO - 2015-11-17 08:01:24,879 INFO : Initialising browser for v8_7 test... 08:01:24 INFO - 2015-11-17 08:01:24,885 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3HBLHu/profile http://localhost:52295/getInfo.html 08:01:28 INFO - 2015-11-17 08:01:28,913 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:01:28 INFO - 2015-11-17 08:01:28,914 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:01:28 INFO - 2015-11-17 08:01:28,914 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:01:28 INFO - 2015-11-17 08:01:28,914 DEBUG : BROWSER_OUTPUT: __metrics 08:01:29 INFO - 2015-11-17 08:01:29,030 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:01:30 INFO - 2015-11-17 08:01:30,505 INFO : Browser initialized. 08:01:30 INFO - 2015-11-17 08:01:30,506 INFO : Running cycle 1/1 for v8_7 test... 08:01:30 INFO - 2015-11-17 08:01:30,506 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp3HBLHu/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:01:42 INFO - 2015-11-17 08:01:42,335 DEBUG : BROWSER_OUTPUT: RSS: Main: 141516800 08:01:42 INFO - 2015-11-17 08:01:42,336 DEBUG : BROWSER_OUTPUT: 08:02:03 INFO - 2015-11-17 08:02:03,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52295/tests/v8_7/run.html (next: http://localhost:52295/tests/v8_7/run.html) 08:02:04 INFO - 2015-11-17 08:02:04,004 DEBUG : BROWSER_OUTPUT: RSS: Main: 620523520 08:02:04 INFO - 2015-11-17 08:02:04,004 DEBUG : BROWSER_OUTPUT: 08:02:04 INFO - 2015-11-17 08:02:04,005 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:02:04 INFO - 2015-11-17 08:02:04,005 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:02:04 INFO - 2015-11-17 08:02:04,005 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:02:04 INFO - 2015-11-17 08:02:04,005 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:02:04 INFO - 2015-11-17 08:02:04,005 DEBUG : BROWSER_OUTPUT: |0;Richards;163.371998039536 08:02:04 INFO - 2015-11-17 08:02:04,005 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.65246762994934 08:02:04 INFO - 2015-11-17 08:02:04,005 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.662363177098 08:02:04 INFO - 2015-11-17 08:02:04,005 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 08:02:04 INFO - 2015-11-17 08:02:04,005 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1970.4724409448818 08:02:04 INFO - 2015-11-17 08:02:04,005 DEBUG : BROWSER_OUTPUT: |5;Earley;777.000777000777 08:02:04 INFO - 2015-11-17 08:02:04,005 DEBUG : BROWSER_OUTPUT: |6;Boyer;12108.43373493976 08:02:04 INFO - 2015-11-17 08:02:04,005 DEBUG : BROWSER_OUTPUT: |7;RegExp;25200 08:02:04 INFO - 2015-11-17 08:02:04,005 DEBUG : BROWSER_OUTPUT: |8;Splay;623.0529595015577 08:02:04 INFO - 2015-11-17 08:02:04,005 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 08:02:04 INFO - 2015-11-17 08:02:04,005 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:02:04 INFO - 2015-11-17 08:02:04,006 DEBUG : BROWSER_OUTPUT: __startTimestamp1447776123997__endTimestamp 08:02:04 INFO - 2015-11-17 08:02:04,006 DEBUG : BROWSER_OUTPUT: 08:02:04 INFO - 2015-11-17 08:02:04,006 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:02:04 INFO - 2015-11-17 08:02:04,006 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:02:04 INFO - 2015-11-17 08:02:04,006 DEBUG : BROWSER_OUTPUT: 08:02:04 INFO - 2015-11-17 08:02:04,006 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.37 Median:163.37 stddev:0.00 (0.0%) 08:02:04 INFO - 2015-11-17 08:02:04,006 DEBUG : BROWSER_OUTPUT: Values: 163.4 08:02:04 INFO - 2015-11-17 08:02:04,006 DEBUG : BROWSER_OUTPUT: 08:02:04 INFO - 2015-11-17 08:02:04,006 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.65 Median:187.65 stddev:0.00 (0.0%) 08:02:04 INFO - 2015-11-17 08:02:04,006 DEBUG : BROWSER_OUTPUT: Values: 187.7 08:02:04 INFO - 2015-11-17 08:02:04,006 DEBUG : BROWSER_OUTPUT: 08:02:04 INFO - 2015-11-17 08:02:04,006 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.66 Median:280.66 stddev:0.00 (0.0%) 08:02:04 INFO - 2015-11-17 08:02:04,006 DEBUG : BROWSER_OUTPUT: Values: 280.7 08:02:04 INFO - 2015-11-17 08:02:04,006 DEBUG : BROWSER_OUTPUT: 08:02:04 INFO - 2015-11-17 08:02:04,006 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 08:02:04 INFO - 2015-11-17 08:02:04,007 DEBUG : BROWSER_OUTPUT: Values: 5030.2 08:02:04 INFO - 2015-11-17 08:02:04,007 DEBUG : BROWSER_OUTPUT: 08:02:04 INFO - 2015-11-17 08:02:04,007 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1970.47 Median:1970.47 stddev:0.00 (0.0%) 08:02:04 INFO - 2015-11-17 08:02:04,007 DEBUG : BROWSER_OUTPUT: Values: 1970.5 08:02:04 INFO - 2015-11-17 08:02:04,007 DEBUG : BROWSER_OUTPUT: 08:02:04 INFO - 2015-11-17 08:02:04,007 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:777.00 Median:777.00 stddev:0.00 (0.0%) 08:02:04 INFO - 2015-11-17 08:02:04,007 DEBUG : BROWSER_OUTPUT: Values: 777.0 08:02:04 INFO - 2015-11-17 08:02:04,007 DEBUG : BROWSER_OUTPUT: 08:02:04 INFO - 2015-11-17 08:02:04,007 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12108.43 Median:12108.43 stddev:0.00 (0.0%) 08:02:04 INFO - 2015-11-17 08:02:04,007 DEBUG : BROWSER_OUTPUT: Values: 12108.4 08:02:04 INFO - 2015-11-17 08:02:04,007 DEBUG : BROWSER_OUTPUT: 08:02:04 INFO - 2015-11-17 08:02:04,007 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25200.00 Median:25200.00 stddev:0.00 (0.0%) 08:02:04 INFO - 2015-11-17 08:02:04,007 DEBUG : BROWSER_OUTPUT: Values: 25200.0 08:02:04 INFO - 2015-11-17 08:02:04,007 DEBUG : BROWSER_OUTPUT: 08:02:04 INFO - 2015-11-17 08:02:04,007 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:623.05 Median:623.05 stddev:0.00 (0.0%) 08:02:04 INFO - 2015-11-17 08:02:04,007 DEBUG : BROWSER_OUTPUT: Values: 623.1 08:02:04 INFO - 2015-11-17 08:02:04,008 DEBUG : BROWSER_OUTPUT: 08:02:04 INFO - 2015-11-17 08:02:04,008 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 08:02:04 INFO - 2015-11-17 08:02:04,008 DEBUG : BROWSER_OUTPUT: Values: 4840.6 08:02:04 INFO - 2015-11-17 08:02:04,008 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:02:04 INFO - 2015-11-17 08:02:04,008 DEBUG : BROWSER_OUTPUT: 08:02:04 INFO - 2015-11-17 08:02:04,879 INFO : Browser exited with error code: 0 08:02:04 INFO - 2015-11-17 08:02:04,896 INFO : Completed test v8_7 (00:00:40) 08:02:04 INFO - 2015-11-17 08:02:04,981 INFO : Completed test suite (00:20:12) 08:02:04 INFO - 2015-11-17 08:02:04,981 DEBUG : Working with test: dromaeo_css 08:02:04 INFO - 2015-11-17 08:02:04,982 DEBUG : Generating results file: dromaeo_css 08:02:04 INFO - 2015-11-17 08:02:04,983 DEBUG : Working with test: kraken 08:02:04 INFO - 2015-11-17 08:02:04,983 DEBUG : Generating results file: kraken 08:02:04 INFO - 2015-11-17 08:02:04,983 INFO : javascript benchmark 08:02:04 INFO - 2015-11-17 08:02:04,983 DEBUG : Working with test: v8_7 08:02:04 INFO - 2015-11-17 08:02:04,983 DEBUG : Generating results file: v8_7 08:02:04 INFO - 2015-11-17 08:02:04,984 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:02:05 INFO - 2015-11-17 08:02:05,058 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 08:02:05 INFO - 2015-11-17 08:02:05,058 DEBUG : process_Request line: dromaeo_css 6920.58 graph.html#tests=[[72,64,35]] 08:02:05 INFO - 2015-11-17 08:02:05,058 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:02:05 INFO - 2015-11-17 08:02:05,091 DEBUG : process_Request line: kraken 1498.00 graph.html#tests=[[232,64,35]] 08:02:05 INFO - 2015-11-17 08:02:05,091 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:02:05 INFO - 2015-11-17 08:02:05,123 DEBUG : process_Request line: v8_7 19990.85 graph.html#tests=[[230,64,35]] 08:02:05 INFO - 2015-11-17 08:02:05,125 INFO : javascript benchmark 08:02:05 INFO - 2015-11-17 08:02:05,129 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [345.6180920083306, 350.9280597477517, 351.17473936249814, 351.90850378901496, 353.9451385035319, 16519.75220371694, 17417.477475675732, 18864.811351886477, 19019.0, 19040.0, 17460.82539174608, 17625.735613965768, 17638.38265660702, 17786.377476788315, 18029.0, 5322.946770532293, 5359.0, 5437.755301011444, 5502.0921547944545, 5505.476979686923, 5456.045192091388, 5493.560515158798, 5497.8075767348155, 5499.395066542677, 5499.945000549983, 3956.1494278730065, 4060.614241647039, 5352.197170424448, 5445.700486473243, 5456.427075157111, 5778.075507918734, 5937.67342796146, 5947.524198064166, 5979.46184843364, 5985.970070149665, 5142.948570514284, 5234.607404444682, 5236.581073514109, 5238.5023422774775, 5243.632945693803, 15797.68404631901, 16558.420455284006, 19443.125059372363, 20588.176472941213, 21354.572908541897, 2288.9542209155725, 2306.6194077977116, 2385.8091352691918, 2541.1741184115235, 2685.2883985743792, 13138.211707297593, 13266.66833329165, 13498.59504214875, 13543.661408464768, 13706.040577159603, 1658.4444211189266, 1751.95620109497, 1800.522861441719, 1859.386402487176, 1939.1273926732886, 59483.70258148725, 59811.70094149545, 61450.38549614491, 61721.07418388773, 61932.69033654803, 9544.761380965392, 9707.66023189185, 9915.603375865028, 9933.0, 9987.80024399508, 12927.5475358362, 12952.676183095498, 12955.352232388343, 12972.545960891324, 12976.221426714428, 7124.821879453055, 7216.603086830275, 7226.819329516699, 7376.557406555624, 7428.071491063617, 6646.6676666166495, 6676.998450232504, 6730.091437655854, 7072.080629518233, 7175.856482870313, 5900.557458190653, 5975.910361344583, 5986.850328741816, 6012.579119461683, 6027.427394397525, 1657.4861792844256, 1708.5557754983793, 1713.6915355235928, 1714.8285171483, 1717.3216579451048, 930.7021753038963, 974.7806743482802, 977.8142152990908, 1000.8798944126606, 1035.6841163445072, 14594.781078283835, 17460.738088928676, 17505.212265448085, 17836.55408614769, 18016.36942706999, 503.3582182716992, 507.7613521644821, 511.6571896829133, 532.5647380310028, 918.9770255743659, 6309.779157729549, 6334.398232167937, 6338.556301058881, 6418.903716444257, 6469.51478639104, 535552.0, 574736.0, 620271.0, 634520.0, 635453.0, 77587.61206193933, 77907.61046194845, 80877.59561202156, 81062.0, 81562.0, 511.29186077282486, 516.8216965147018, 518.5618152660995, 520.2404489445452, 521.7991073436755, 10974.0, 11115.38672970145, 11294.887051129712, 11383.829242561202, 11386.487608057823, 35975.640243598275, 36074.45888311625, 36747.47997928128, 36978.07554811151, 37266.06834829151, 44508.55491445044, 44707.55292447164, 46227.0, 48982.265266020324, 49117.75441122914, 6576.079348891063, 6741.898871517029, 6789.388954994074, 6808.7276508939085, 6827.692753826189, 11955.0, 12026.699332516757, 12164.209326393757, 12291.75416491683, 12297.877021229673, 10574.788504230026, 10673.8932610676, 10872.945635271773, 10880.945595271973, 10886.183536234656, 10254.487275636338, 10589.788204236027, 10627.09669678086, 10691.251612387057, 10847.40339281347, 10393.532291047073, 10417.374957502574, 10603.0, 10810.0, 11040.061594764535, 6684.43182329488, 6764.086848275617, 6765.695543700644, 6769.255381908085, 6773.729050838108, 8222.588870556328, 10524.631637892637, 10765.0, 10954.561817527529, 10969.067629251284], "dojo.html": [3198.32835104628, 3233.127055694964, 3266.183454136466, 3278.409886220481, 3292.60488741351, 5243.816466423676, 5346.27825243593, 5358.196270559418, 5365.517103460687, 5463.262459567957, 5322.4411436799155, 5332.280142180804, 5352.545033672142, 5362.383325917521, 5416.214648875921, 4793.257045158006, 4861.392325959255, 4962.206047032476, 5016.272640467148, 5021.196608542616, 4795.0, 4969.701817890938, 5007.799688012494, 5045.520675535819, 5062.569681577071, 4798.328234047236, 4931.679440836334, 4976.303317535548, 5002.849914502534, 5002.974985125087, 4907.484714105039, 4922.458529561745, 4924.581410580105, 4931.556159945622, 4984.451710311862, 4892.730899800509, 4914.410270767495, 4921.827736029258, 4931.802727890916, 4970.7017578945015, 5114.309568208281, 5182.041322355339, 5195.9480405195845, 5263.34208223972, 5316.308879845596, 5868.2664666916635, 5892.911606325909, 5896.911546326765, 5903.350631430582, 5939.3763654816485, 5753.0, 5961.0, 5962.910556341659, 5963.642181469126, 5969.015112506475, 5439.428859969686, 5470.261514695545, 5524.005678977783, 5547.5007249347345, 5594.468525490072, 5927.229460170237, 5940.881182376328, 5969.3732158122775, 5986.5809393342915, 5991.310999235056, 5763.049096899049, 5776.971115144482, 5780.421957804186, 5780.624259423124, 5787.739551720183, 5803.912941305884, 5831.300243970751, 5868.031774757117, 5929.347771745104, 5963.910541341883, 5888.087346461305, 5893.941060589425, 5894.941050589525, 5909.852253693606, 5949.077892926603, 5703.771849125988, 5864.589478736448, 5897.351291357947, 5899.498542623839, 5907.4683278505145, 4331.5018772840895, 4401.713888597295, 4415.072834704748, 4429.734215947054, 4524.389207457017, 3977.622125898035, 4057.797110144481, 4064.4919385076864, 4088.0597462583773, 4114.033202197481, 5471.37079235893, 5629.437056294338, 5670.234518340054, 5671.2060311556415, 5673.461021202979, 5860.120981852671, 5916.319623243296, 5938.673372964442, 5941.821745347646, 5984.73068711909, 5495.313085864267, 5497.945020549823, 5501.807436739695, 5508.9724551376985, 5571.303587051619, 4971.776270067856, 5040.873978150576, 5042.0, 5081.085404627129, 5083.822066227738, 5990.191324171268, 5999.190109335271, 6056.454919057306, 6056.848578785478, 6080.543959203077, 5914.585978981602, 5916.378780228014, 5916.615419997686, 5924.348321684525, 5924.377940316204, 5839.708014599168, 5941.940580594139, 6096.0, 6096.512279017579, 6096.634201947897, 5817.9127313091185, 5906.350301466749, 5906.970465147819, 5910.970445147746, 5958.136070269873, 5943.0, 5957.702114894151, 5961.642301461926, 5965.642061476326, 5972.761089556543, 5665.773369065191, 5667.943320566742, 5787.363390027178, 5812.9709351452975, 5832.795852145155, 5890.4698577128265, 5895.351511333664, 5896.764129434775, 5902.1441890926435, 5911.615744976562, 5738.110592858114, 5772.913406298825, 5782.335031471434, 5784.768609255582, 5789.0, 5693.202951586864, 5731.656100633975, 5789.363170051207, 5802.47777700009, 5930.258717660293, 5732.283464566929, 5751.597388182787, 5760.567957403296, 5764.394738552392, 5783.334916484489], "mootools.html": [1218.3177420644445, 1677.3374517065758, 1699.9320027198912, 1708.957535903099, 1730.3857130718586, 7058.717651293949, 7376.373008294295, 7467.029286192801, 7470.626468676558, 7471.626418679065, 7601.049868766404, 7721.343685786715, 7724.96137519313, 7733.11069227039, 7738.767836964886, 2213.236433430464, 2233.7207849018873, 2234.854734442264, 2237.7650346713604, 2238.440389902524, 2079.3969748772915, 2108.641530939744, 2121.2575598540543, 2122.0981083039646, 2123.596516661837, 2208.293346129239, 2217.2793842001333, 2218.7226596675414, 2230.208276061999, 2298.9655155172604, 2254.6730724045087, 2274.5678321119017, 2285.69143165673, 2285.988570057156, 2286.325533967484, 2270.9545809083893, 2284.920027799036, 2284.977150228493, 2285.931422057341, 2286.8056215221727, 6900.689468973908, 7018.894716579255, 7715.0, 7739.651715672809, 7765.1458339582605, 4639.605633521155, 4743.905121897543, 4752.334673145762, 4757.357756702835, 4760.024195040009, 3120.578721872541, 3122.8438578071004, 3129.092563156682, 3166.9683303166903, 3220.066180807563, 995.512199022481, 1019.755258737905, 1029.3772267778036, 1032.6953548703075, 1060.0512541275593, 10845.0, 10879.0, 10913.618023369145, 10931.617393391272, 10939.83590246139, 4322.15717935006, 4367.825286988548, 4403.933940990888, 4425.756583387944, 4436.6007059364165, 9387.57755900986, 9410.294227932796, 9411.576479058458, 9446.763830904283, 9467.384619999679, 4836.516348365206, 4841.661083724176, 4844.660873738875, 4844.781984810692, 4857.465678775332, 4386.978065109718, 4393.143337049245, 4394.2969124939855, 4397.340398940185, 4398.010447649317, 3658.2866341063236, 3713.7400381973544, 3715.8327875245677, 3733.4586484959527, 3754.3617585010616, 1223.559518573313, 1232.0697873105748, 1235.2897084176454, 1237.2638280223252, 1241.0, 950.6625148072472, 963.7446076789516, 964.1178321835582, 987.3138168972639, 1100.9724756881142, 7124.8575028499135, 7158.785236442915, 7200.891986620205, 7204.531705439234, 7210.026646402774, 447.0388664371627, 448.41705782482643, 451.6589974569245, 456.1492815898326, 456.63697360598405, 5329.733513324319, 5367.490088441592, 5370.087085195526, 5616.634918730269, 5705.914411283834, 9229.815403692022, 9416.293777966679, 9542.3320367575, 9546.331756777097, 9558.713238602853, 9223.0, 9282.0, 9295.90704092964, 9578.425294482353, 9588.472634005197, 7343.77968660941, 7387.335139837333, 7393.852122957511, 7439.25607439241, 7483.962580187064, 7048.788536343918, 7139.750108746169, 7177.569345839266, 7178.5692858428665, 7194.532355396883, 8277.048139463797, 8322.833543328978, 8371.330293576377, 8424.326053915795, 8481.236688698047, 8441.198086181803, 8490.363222758195, 8633.870491942751, 8656.826863462822, 8812.911870881466, 6946.097007389007, 6994.090768200102, 6997.265287144776, 7026.262242464672, 7031.226565077735, 7416.96291518539, 7596.126445458622, 7660.387169026353, 7664.233576642514, 7679.116901556169, 7055.894161587477, 7126.572405655677, 7166.247544007804, 7221.494495385273, 7279.381252593589, 6976.372126508639, 6982.162140543167, 7000.929990700028, 7024.824379390556, 7052.153741551047, 6910.101686780888, 6922.20394654601, 6950.061741665013, 6951.478639102189, 6951.548149370275, 6266.655333956676, 6443.323451037573, 6455.806325810233, 6460.192475940507, 6463.806085817245, 6530.444912182517, 6545.14913061299, 6549.279579246374, 6554.901676474761, 6556.18047744032], "ext.html": [551.8289330307603, 591.7899145803242, 597.8057131432284, 600.7146605362456, 605.1195510532176, 29959.700402995964, 36384.09039774007, 36787.08032299194, 37135.62864371356, 37180.99999999996, 42609.78695106528, 42901.35647965275, 42915.57084429155, 42930.356044659275, 42944.0, 7667.693292268303, 7786.4938778979185, 8693.565321733904, 8857.335699822506, 8866.689665861697, 10454.634087806928, 10595.470226488684, 10693.518791654355, 10706.839397409045, 10723.249372543925, 10365.807932087831, 10418.21863360251, 10427.635032773855, 10433.217508686841, 10436.217283703752, 7823.10034346049, 8002.51984880909, 8018.839623207561, 10293.0, 10488.423136727477, 10232.079112879803, 10363.06732394088, 10376.896231037668, 10377.792444151075, 10388.688339349832, 40787.38818917719, 40849.59150408488, 40974.79512602418, 41302.173956521, 41344.0, 3110.5178697301953, 3154.6056742907135, 3490.703290220334, 3597.316509863144, 3962.346212874872, 29924.401511969856, 30411.543826842615, 30560.69439305601, 30788.538171927437, 31651.20871978196, 3458.706009989154, 3480.286541259036, 3598.4242521196743, 3611.7832930024283, 3639.9808053744996, 289294.0, 292267.53866230743, 292328.0, 292930.99999999785, 293111.0, 59543.0, 60572.0, 60762.39237607567, 61352.0, 61839.6908015466, 71493.0, 72611.0, 72878.2712172882, 72895.63552182312, 72933.2706672937, 15616.609584760472, 15767.053976761432, 15767.526974190792, 15782.0, 15798.289076991563, 11803.170508571186, 11810.0, 11818.704532386588, 11819.940900295443, 11828.76342473163, 20178.0, 20213.696794548094, 20509.794902051086, 20559.691604625943, 20581.38255852327, 8057.194280572013, 8233.217844304781, 8302.128276530999, 8319.126491718282, 8325.8334833303, 865.5326123893027, 882.8057827277988, 930.7952250504878, 1043.1967385113421, 1053.6628278950816, 28606.570901436495, 28699.42601148007, 28857.0, 29054.273643158667, 32993.67006329954, 1001.6594357918343, 1012.711377257478, 1012.7822518158631, 1048.5072016152396, 1054.393723608928, 14589.635259118395, 14699.92650036743, 14966.625834354229, 15145.621359466102, 15235.61910952213, 402400.0, 407807.0, 408477.0, 408886.0, 409102.0, 54248.728756355966, 54867.0, 54968.0, 54988.72505637446, 55014.0, 1283.1624774599707, 1290.7160424706549, 1299.6101169649066, 1349.419749507721, 1359.1029920252586, 26622.600660989712, 27429.45141097207, 28503.572446412905, 28704.282392940342, 29670.851645742496, 50346.74826625844, 50961.490385095676, 50965.745171273906, 51046.48953510417, 51068.23397649112, 312005.0, 313410.0, 314500.0, 314586.0, 314949.0, 28795.0, 29167.416651667274, 32127.518087228244, 32541.674583253865, 32766.34467310688, 37707.0, 40710.592894071866, 42649.0, 42661.573384267, 43269.567304326556, 35328.64671353356, 35739.88991266038, 35845.462318064725, 36953.44569831401, 37411.25177496489, 35484.46773298351, 35600.149012790265, 35935.46096808602, 36213.63786362103, 36263.81868090748, 34945.82527087348, 35253.647463525034, 35422.822885885405, 35713.821430892676, 35779.0, 30542.0, 31370.215744605655, 32579.674203257666, 32993.835030824695, 33021.0, 24590.877045615372, 24927.37681557903, 24960.001599936524, 25335.0, 25382.49235015326], "prototype.html": [315.6922001048978, 316.6643358040477, 319.3453420487999, 320.51602080857907, 322.79663811798565, 5944.5541584381235, 6047.092936059593, 6077.878442431154, 6080.05759107338, 6126.326104128542, 5857.7364018619155, 6013.248343957005, 6063.909041364372, 6069.393060693928, 6075.51395888329, 4410.867673969786, 4506.211413002711, 4592.127495775792, 4596.218642830727, 4600.585947264745, 4531.071130418273, 4612.930806037895, 4635.0, 4649.0, 4651.186042442576, 4595.333676616889, 4597.42532183477, 4601.401817763686, 4604.7927843247135, 4607.35497030416, 4593.586577208034, 4605.332226827108, 4608.032313214229, 4610.67725259232, 4614.700044497131, 3953.2291203215386, 4042.6967977401814, 4046.898827529306, 4048.068944142834, 4051.412545180962, 5726.112452569859, 5736.942630573724, 5744.798932037401, 5758.107493338539, 5775.942240577582, 5377.0052540279785, 5381.865453363658, 5388.649737767072, 5390.811321603725, 5396.271503347037, 6126.0, 6256.405641464054, 6260.248770147566, 6371.649559274238, 6417.06952491886, 4446.644268458515, 4461.5092339842595, 4470.307102399101, 4470.418845550058, 4476.776161191928, 6600.570962887397, 6681.565698229648, 6682.532222744361, 6685.164354455693, 6686.632235227061, 4488.685791994529, 4615.0, 4624.190766615829, 4626.606738427204, 4628.814847406066, 4653.069386122789, 4688.179568575486, 4691.437027556715, 4691.53084691535, 4695.389599352063, 5342.893142137135, 5386.48828361305, 5394.62237643369, 5397.541208997279, 5401.054815407288, 6478.222613286436, 6501.902471462932, 6512.804615861532, 6513.967430162819, 6516.934830651728, 1629.2586872973006, 1631.2659303313555, 1660.1201363277482, 1660.9584760380847, 1672.916354182286, 1103.7130346110068, 1111.6109361723493, 1133.3539882267194, 1137.4881303413497, 1138.8918052784973, 6199.535034872402, 6209.9379006210265, 6214.658193799384, 6215.844603884939, 6216.129741836146, 6661.26726060133, 6680.966595166993, 6687.264400915896, 6703.262641109474, 6708.2956289589865, 6067.24159480065, 6221.3156552780065, 6221.906671399933, 6222.066689996446, 6225.844353891099, 3589.6410358963894, 3623.2934577757082, 3623.5108260385036, 3625.7643253188457, 3625.8912232633065, 6900.2409734929115, 6912.723491060402, 6927.064846245793, 6927.203371612329, 6932.549384290005, 6621.039949207338, 6763.188417389944, 6765.763198288135, 6766.0, 6778.152730908637, 6660.8667826643195, 6778.423833974168, 6905.378515933489, 6925.411340036053, 6929.445644348541, 6564.4420224281475, 6691.665416729242, 6717.0, 6733.192016957996, 6769.458443324621, 6694.966525167343, 6697.397234248941, 6698.497612679166, 6705.698243578953, 6710.798676039727, 6843.931560684329, 7016.5790052597, 7017.614031228127, 7019.08751862275, 7024.121984751906, 4633.235516139934, 4636.350910872548, 4637.188492013816, 4637.791299391603, 4638.652101092364, 6751.898721519083, 6755.729770809309, 6760.459163266829, 6760.797176084725, 6761.594304341756, 6407.167068281094, 6537.1501704778075, 6539.4768418525455, 6563.442107420923, 6570.704318305783, 6508.479321654351, 6553.377429144223, 6557.377049180321, 6557.770478033246, 6565.606063636197, 6423.293437721753, 6435.06691529735, 6436.613803171825, 6439.710213040518, 6450.967745161244, 6489.156409666713, 6548.410643042149, 6595.274519802914, 6611.66941652925, 6621.437177839937, 6440.613563186036, 6441.355864413521, 6446.548741588043, 6450.0969864218105, 6454.935450645434], "yui.html": [631.3844002097956, 672.579637726421, 733.666181887241, 796.2435686098208, 805.4643661964793, 12652.0, 12788.48846046157, 12964.416601252931, 12967.546135885246, 13087.21476711398, 12543.121981461301, 12597.055220858427, 12685.238885666844, 12687.492500299977, 12701.682457938534, 692.5325405351367, 703.9612821294827, 817.4196320612342, 819.8729196974449, 834.4659417972503, 837.2966707965307, 837.5351679817699, 838.4172999765166, 844.8986121665378, 845.1084106267884, 858.2704701004159, 862.6420035685184, 863.7581477186397, 863.8445079885649, 864.3992425264444, 710.4919982212717, 719.1118968074423, 850.4854562989395, 867.5835598912495, 867.6659486097834, 637.5154882289447, 640.8718256348702, 640.9070684750685, 641.3169973977746, 641.720851429625, 12671.809922851164, 12749.42627581761, 12794.744105117845, 12833.550825721148, 12839.871601283961, 12004.459799309052, 12064.879351206464, 12422.689432764162, 12442.75114497705, 12563.811542826865, 9942.652007179786, 9989.150922171624, 10084.697459076166, 10170.847437288447, 10280.948595256976, 3557.0, 3585.928281434383, 3586.8027258500774, 3608.765430247052, 3735.570409402926, 47760.52239477595, 47865.04269914617, 47911.76044119757, 48058.75970620124, 48089.0, 9380.437173769596, 9387.389819661701, 9434.103760142776, 9444.8583271251, 9544.33189676716, 18298.0, 18347.082645867653, 18544.0, 18572.164252608665, 18598.0, 6890.10428644273, 6928.099347084847, 6984.196817365966, 7055.506114572034, 7086.645667716697, 4203.306454434984, 4343.565643435694, 4372.300431930939, 4385.276429389179, 4452.065066336106, 2725.822821516595, 2738.151173136334, 2750.8624568771484, 2752.8210666306627, 2758.7792976561827, 427.84383699949296, 584.2113147251177, 594.9970250148722, 598.5540772124795, 598.931122920861, 574.178924138486, 582.909649004405, 600.504583718434, 634.501915995941, 637.1175921348965, 8215.488215488193, 8217.95891020541, 8407.285380742705, 8532.658693652184, 9461.810763784686, 506.9974650126726, 607.2743072028883, 620.3393386043849, 637.7895294552786, 644.8484606117559, 3627.818609069536, 4036.4257939403656, 4454.354118652777, 4527.683062185615, 4542.88642783933, 53680.46319536755, 54351.18473222905, 54710.72644636752, 54885.0, 54979.725101375036, 47653.76173119112, 47782.76108619435, 48125.75937120292, 48252.0, 50604.74697626488, 43158.35262471066, 44249.33625995613, 44295.557044429144, 44916.0, 47324.0, 8732.69435569752, 8862.601182946912, 8865.51239681798, 8920.86618700707, 9271.119243671841, 35717.28565428729, 36525.26949461049, 36641.63358366489, 36647.63352366549, 36837.26325473529, 45928.0, 45958.54041459542, 46122.0, 46612.53387466082, 47454.0, 7859.253370929752, 8166.510009399455, 8416.2004609562, 8722.215000649972, 8811.471311721318, 12675.93662031684, 12768.61694149177, 12784.360781960679, 12836.614901552968, 13465.326733663474, 10927.890721092688, 11613.883861161617, 12032.75934481288, 12454.564090256797, 12493.500259989862, 11834.822477663014, 12163.635090947286, 12279.017678585513, 12679.366031698193, 12685.365731713193, 11272.436378181223, 11274.299350020388, 11336.546538138382, 11390.658280251606, 11752.236104653512, 8851.513166775889, 8943.552822358986, 9176.816463670822, 9374.269500300969, 9391.953040234755, 8904.421212621159, 9104.271658267191, 9154.267658587163, 9325.720228393158, 9493.572789224363]}, "summary": {"lowerIsBetter": false, "suite": 6920.584173569321, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 8080.880870571685, "unit": "ms", "value": 8080.880870571685}, "dojo.html": {"lowerIsBetter": false, "filtered": 5412.391770387483, "unit": "ms", "value": 5412.391770387483}, "mootools.html": {"lowerIsBetter": false, "filtered": 4373.270144135079, "unit": "ms", "value": 4373.270144135079}, "ext.html": {"lowerIsBetter": false, "filtered": 19104.693532793706, "unit": "ms", "value": 19104.693532793706}, "prototype.html": {"lowerIsBetter": false, "filtered": 4872.706147676966, "unit": "ms", "value": 4872.706147676966}, "yui.html": {"lowerIsBetter": false, "filtered": 6169.542918525788, "unit": "ms", "value": 6169.542918525788}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-069"}, "testrun": {"date": 1447774912, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117053006", "branch": "Fx-Team", "revision": "b8be6b563c8ab1a42071e5aecee81b96910a50ac"}}, {"talos_counters": {}, "results": {"audio-dft": [162.0, 161.0, 162.0, 160.0, 160.0, 163.0, 160.0, 166.0, 161.0, 163.0], "ai-astar": [109.0, 110.0, 105.0, 110.0, 111.0, 110.0, 100.0, 110.0, 110.0, 109.0], "imaging-gaussian-blur": [110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0], "audio-beat-detection": [153.0, 123.0, 150.0, 167.0, 129.0, 147.0, 153.0, 125.0, 169.0, 123.0], "json-stringify-tinderbox": [69.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0], "stanford-crypto-pbkdf2": [151.0, 140.0, 154.0, 151.0, 154.0, 141.0, 151.0, 149.0, 146.0, 143.0], "json-parse-financial": [59.0, 59.0, 59.0, 60.0, 58.0, 60.0, 60.0, 68.0, 57.0, 56.0], "stanford-crypto-sha256-iterative": [66.0, 66.0, 66.0, 66.0, 67.0, 65.0, 68.0, 68.0, 67.0, 67.0], "audio-fft": [71.0, 72.0, 85.0, 95.0, 73.0, 72.0, 73.0, 99.0, 90.0, 71.0], "imaging-darkroom": [145.0, 144.0, 145.0, 146.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0], "stanford-crypto-ccm": [115.0, 122.0, 122.0, 113.0, 116.0, 127.0, 123.0, 120.0, 129.0, 123.0], "audio-oscillator": [90.0, 89.0, 136.0, 90.0, 91.0, 91.0, 135.0, 90.0, 91.0, 132.0], "stanford-crypto-aes": [84.0, 84.0, 92.0, 85.0, 85.0, 86.0, 85.0, 85.0, 96.0, 86.0], "imaging-desaturate": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0]}, "summary": {"lowerIsBetter": true, "suite": 1498.0, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 80.1, "unit": "ms", "value": 80.1}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 148.0, "unit": "ms", "value": 148.0}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 143.9, "unit": "ms", "value": 143.9}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 121.0, "unit": "ms", "value": 121.0}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 145.2, "unit": "ms", "value": 145.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 59.6, "unit": "ms", "value": 59.6}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 103.5, "unit": "ms", "value": 103.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.4, "unit": "ms", "value": 108.4}, "audio-dft": {"lowerIsBetter": true, "filtered": 161.8, "unit": "ms", "value": 161.8}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 66.6, "unit": "ms", "value": 66.6}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 68.3, "unit": "ms", "value": 68.3}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 109.5, "unit": "ms", "value": 109.5}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 86.8, "unit": "ms", "value": 86.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 95.3, "unit": "ms", "value": 95.3}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-069"}, "testrun": {"date": 1447774912, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117053006", "branch": "Fx-Team", "revision": "b8be6b563c8ab1a42071e5aecee81b96910a50ac"}}, {"talos_counters": {}, "results": {"DeltaBlue": [187.65246762994934], "Encrypt": [280.662363177098], "NavierStokes": [4840.579710144928], "Decrypt": [5030.150753768844], "Splay": [623.0529595015577], "Richards": [163.371998039536], "RegExp": [25200.0], "Earley": [777.000777000777], "Boyer": [12108.43373493976], "RayTrace": [1970.4724409448818]}, "summary": {"lowerIsBetter": false, "suite": 19990.84853514961, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 352.34282199999996, "unit": "score", "value": 352.34282199999996}, "Encrypt": {"lowerIsBetter": false, "filtered": 948.4029029999999, "unit": "score", "value": 948.4029029999999}, "NavierStokes": {"lowerIsBetter": false, "filtered": 306.5748502994012, "unit": "score", "value": 306.5748502994012}, "Decrypt": {"lowerIsBetter": false, "filtered": 52.91710189810189, "unit": "score", "value": 52.91710189810189}, "Splay": {"lowerIsBetter": false, "filtered": 130.793055, "unit": "score", "value": 130.793055}, "RegExp": {"lowerIsBetter": false, "filtered": 36.150198412698415, "unit": "score", "value": 36.150198412698415}, "Richards": {"lowerIsBetter": false, "filtered": 216.08354200000005, "unit": "score", "value": 216.08354200000005}, "Earley": {"lowerIsBetter": false, "filtered": 857.737881, "unit": "score", "value": 857.737881}, "Boyer": {"lowerIsBetter": false, "filtered": 55.0412228855721, "unit": "score", "value": 55.0412228855721}, "RayTrace": {"lowerIsBetter": false, "filtered": 375.5388731268733, "unit": "score", "value": 375.5388731268733}}}, "test_machine": {"platform": "x86_64", "osversion": "Ubuntu 12.04", "os": "linux", "name": "talos-linux64-ix-069"}, "testrun": {"date": 1447774912, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151117053006", "branch": "Fx-Team", "revision": "b8be6b563c8ab1a42071e5aecee81b96910a50ac"}}] 08:02:05 INFO - RETURN: dromaeo_css: 6920.58 08:02:05 INFO - RETURN: kraken: 1498.00 08:02:05 INFO - RETURN: v8_7: 19990.85 08:02:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19990.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1498.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6920.58"}}} 08:02:05 INFO - Return code: 0 08:02:05 INFO - # TBPL SUCCESS # 08:02:05 INFO - Running post-action listener: _resource_record_post_action 08:02:05 INFO - Running post-run listener: _resource_record_post_run 08:02:06 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 8192; Write bytes: 519360512; Read time: 288; Write time: 662144 08:02:06 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 4096; Write bytes: 235327488; Read time: 188; Write time: 409068 08:02:06 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276357120; Read time: 100; Write time: 228608 08:02:06 INFO - Running post-run listener: _upload_blobber_files 08:02:06 INFO - Blob upload gear active. 08:02:06 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:02:06 INFO - Copying logs to upload dir... 08:02:06 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.505885 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2015-11-17 08:02:04.665643) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 08:02:04.669142) ========= 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=d96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/TirxCQ1JQkK2lQEn1bNSsg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009995 build_url: 'https://queue.taskcluster.net/v1/task/TirxCQ1JQkK2lQEn1bNSsg/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-17 08:02:04.720527) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 08:02:04.720865) ========= 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=d96ba47f58e561e1fc64d816000001cc-1447768919.957589-298264278 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 08:02:04.770397) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 08:02:04.770723) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 08:02:04.771013) ========= ========= Total master_lag: 0.21 =========