builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1450487193.48 results: success (0) buildid: 20151218143005 builduid: 641298e09aec42b3a7b64d9ed1d3525a revision: 51a5ff26043b41027d4e32aaf16f93dfe0ec17b8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:33.479977) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:33.480785) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:33.481107) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006292 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:33.531439) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:33.531750) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:33.608769) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:33.609025) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004714 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:33.658855) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:33.659137) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:33.659545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:33.659822) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 17:06:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2015-12-18 17:06:33 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176990 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:33.848765) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:33.849101) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016860 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:33.902171) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:33.902553) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 51a5ff26043b41027d4e32aaf16f93dfe0ec17b8 --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 51a5ff26043b41027d4e32aaf16f93dfe0ec17b8 --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=bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 17:06:34,021 truncating revision to first 12 chars 2015-12-18 17:06:34,021 Setting DEBUG logging. 2015-12-18 17:06:34,021 attempt 1/10 2015-12-18 17:06:34,021 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/51a5ff26043b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 17:06:34,247 unpacking tar archive at: fx-team-51a5ff26043b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.483325 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:34.398717) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:34.399019) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:34.406530) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:34.406925) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 17:06:34.407429) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-18 17:06:34.407722) ========= /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=bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:06:34 INFO - MultiFileLogger online at 20151218 17:06:34 in /builds/slave/test-pgo 17:06:34 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 17:06:34 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 17:06:34 INFO - {'append_to_log': False, 17:06:34 INFO - 'base_work_dir': '/builds/slave/test-pgo', 17:06:34 INFO - 'blob_upload_branch': 'Fx-Team', 17:06:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 17:06:34 INFO - 'branch': 'Fx-Team', 17:06:34 INFO - 'buildbot_json_path': 'buildprops.json', 17:06:34 INFO - 'config_files': ('talos/linux_config.py',), 17:06:34 INFO - 'default_actions': ('clobber', 17:06:34 INFO - 'read-buildbot-config', 17:06:34 INFO - 'download-and-extract', 17:06:34 INFO - 'populate-webroot', 17:06:34 INFO - 'create-virtualenv', 17:06:34 INFO - 'install', 17:06:34 INFO - 'run-tests'), 17:06:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:06:34 INFO - 'download_minidump_stackwalk': True, 17:06:34 INFO - 'download_symbols': 'ondemand', 17:06:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:06:34 INFO - 'tooltool.py': '/tools/tooltool.py', 17:06:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:06:34 INFO - '/tools/misc-python/virtualenv.py')}, 17:06:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:06:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:06:34 INFO - 'installer_path': 'installer.exe', 17:06:34 INFO - 'log_level': 'info', 17:06:34 INFO - 'log_name': 'talos', 17:06:34 INFO - 'log_to_console': True, 17:06:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:06:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:06:34 INFO - 'opt_config_files': (), 17:06:34 INFO - 'pip_index': False, 17:06:34 INFO - 'sps_profile': False, 17:06:34 INFO - 'sps_profile_interval': 0, 17:06:34 INFO - 'suite': 'dromaeojs', 17:06:34 INFO - 'system_bits': '64', 17:06:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:06:34 INFO - 'title': 'talos-linux64-ix-062', 17:06:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:06:34 INFO - 'use_talos_json': True, 17:06:34 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 17:06:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:06:34 INFO - 'work_dir': 'build'} 17:06:34 INFO - ##### 17:06:34 INFO - ##### Running clobber step. 17:06:34 INFO - ##### 17:06:34 INFO - Running pre-action listener: _resource_record_pre_action 17:06:34 INFO - Running main action method: clobber 17:06:34 INFO - rmtree: /builds/slave/test-pgo/build 17:06:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 17:06:35 INFO - Running post-action listener: _resource_record_post_action 17:06:35 INFO - ##### 17:06:35 INFO - ##### Running read-buildbot-config step. 17:06:35 INFO - ##### 17:06:35 INFO - Running pre-action listener: _resource_record_pre_action 17:06:35 INFO - Running main action method: read_buildbot_config 17:06:35 INFO - Using buildbot properties: 17:06:35 INFO - { 17:06:35 INFO - "project": "", 17:06:35 INFO - "product": "firefox", 17:06:35 INFO - "script_repo_revision": "production", 17:06:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:06:35 INFO - "repository": "", 17:06:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 17:06:35 INFO - "buildid": "20151218143005", 17:06:35 INFO - "pgo_build": "True", 17:06:35 INFO - "basedir": "/builds/slave/test-pgo", 17:06:35 INFO - "buildnumber": 375, 17:06:35 INFO - "slavename": "talos-linux64-ix-062", 17:06:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:06:35 INFO - "platform": "ubuntu64_hw", 17:06:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 17:06:35 INFO - "branch": "fx-team", 17:06:35 INFO - "repo_path": "integration/fx-team", 17:06:35 INFO - "revision": "51a5ff26043b41027d4e32aaf16f93dfe0ec17b8", 17:06:35 INFO - "stage_platform": "linux64-pgo", 17:06:35 INFO - "builduid": "641298e09aec42b3a7b64d9ed1d3525a", 17:06:35 INFO - "slavebuilddir": "test" 17:06:35 INFO - } 17:06:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:06:35 INFO - Running post-action listener: _resource_record_post_action 17:06:35 INFO - ##### 17:06:35 INFO - ##### Running download-and-extract step. 17:06:35 INFO - ##### 17:06:35 INFO - Running pre-action listener: _resource_record_pre_action 17:06:35 INFO - Running main action method: download_and_extract 17:06:35 INFO - mkdir: /builds/slave/test-pgo/build/tests 17:06:35 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')]} 17:06:35 INFO - https://queue.taskcluster.net/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:06:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/test_packages.json 17:06:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/test_packages.json 17:06:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 17:06:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 17:06:36 INFO - Downloaded 1302 bytes. 17:06:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 17:06:36 INFO - Using the following test package requirements: 17:06:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:06:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:36 INFO - u'jsshell-linux-x86_64.zip'], 17:06:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:06:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:06:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:06:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:06:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:06:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:06:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:06:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:06: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')]} 17:06:36 INFO - https://queue.taskcluster.net/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:06:38 INFO - Downloaded 23120906 bytes. 17:06:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 17:06:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:06:39 INFO - Return code: 0 17:06:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:06:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:39 INFO - https://queue.taskcluster.net/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:06:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:06:40 INFO - Downloaded 23120906 bytes. 17:06:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 17:06:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:06:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:06:42 INFO - Return code: 0 17:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:42 INFO - https://queue.taskcluster.net/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:06:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:06:43 INFO - Downloaded 11132039 bytes. 17:06:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 17:06:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:06:43 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 17:06:43 INFO - Return code: 0 17:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:43 INFO - https://queue.taskcluster.net/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:06:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:06:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:06:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:06:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:06:45 INFO - Downloaded 54639395 bytes. 17:06:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:06:45 INFO - mkdir: /builds/slave/test-pgo/properties 17:06:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 17:06:45 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 17:06:45 INFO - Contents: 17:06:45 INFO - build_url:https://queue.taskcluster.net/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:06:45 INFO - Running post-action listener: _resource_record_post_action 17:06:45 INFO - Running post-action listener: set_extra_try_arguments 17:06:45 INFO - ##### 17:06:45 INFO - ##### Running populate-webroot step. 17:06:45 INFO - ##### 17:06:45 INFO - Running pre-action listener: _resource_record_pre_action 17:06:45 INFO - Running main action method: populate_webroot 17:06:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:06:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:06:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:06:45 INFO - '--tppagecycles', 17:06:45 INFO - '7'], 17:06:45 INFO - 'tests': ['tsvgm']}}, 17:06:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:06:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:06:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:06:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:06:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:06:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:06:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:45 INFO - 'talos_options': ['--e10s'], 17:06:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:06:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:45 INFO - 'tests': ['damp', 'tps']}, 17:06:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:45 INFO - 'talos_options': ['--e10s'], 17:06:45 INFO - 'tests': ['damp', 'tps']}, 17:06:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:06:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:06:45 INFO - 'other': {'tests': ['a11yr', 17:06:45 INFO - 'ts_paint', 17:06:45 INFO - 'tpaint', 17:06:45 INFO - 'sessionrestore', 17:06:45 INFO - 'sessionrestore_no_auto_restore']}, 17:06:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:06:45 INFO - 'tests': ['a11yr', 17:06:45 INFO - 'ts_paint', 17:06:45 INFO - 'tpaint', 17:06:45 INFO - 'sessionrestore', 17:06:45 INFO - 'sessionrestore_no_auto_restore']}, 17:06:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:06:45 INFO - 'tests': ['a11yr', 17:06:45 INFO - 'ts_paint', 17:06:45 INFO - 'tpaint', 17:06:45 INFO - 'sessionrestore', 17:06:45 INFO - 'sessionrestore_no_auto_restore']}, 17:06:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:06:45 INFO - 'tests': ['a11yr', 17:06:45 INFO - 'ts_paint', 17:06:45 INFO - 'tpaint', 17:06:45 INFO - 'sessionrestore', 17:06:45 INFO - 'sessionrestore_no_auto_restore']}, 17:06:45 INFO - 'other_l64': {'tests': ['a11yr', 17:06:45 INFO - 'ts_paint', 17:06:45 INFO - 'tpaint', 17:06:45 INFO - 'sessionrestore', 17:06:45 INFO - 'sessionrestore_no_auto_restore']}, 17:06:45 INFO - 'other_nol64': {'tests': ['a11yr', 17:06:45 INFO - 'ts_paint', 17:06:45 INFO - 'tpaint', 17:06:45 INFO - 'sessionrestore', 17:06:45 INFO - 'sessionrestore_no_auto_restore']}, 17:06:45 INFO - 'svgr': {'tests': ['tsvgx', 17:06:45 INFO - 'tsvgr_opacity', 17:06:45 INFO - 'tart', 17:06:45 INFO - 'tscrollx', 17:06:45 INFO - 'cart']}, 17:06:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:06:45 INFO - 'tests': ['tsvgx', 17:06:45 INFO - 'tsvgr_opacity', 17:06:45 INFO - 'tart', 17:06:45 INFO - 'tscrollx', 17:06:45 INFO - 'cart']}, 17:06:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:45 INFO - 'tests': ['tp5o']}, 17:06:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:45 INFO - 'talos_options': ['--e10s'], 17:06:45 INFO - 'tests': ['tp5o']}, 17:06:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:45 INFO - 'talos_options': ['--xperf_path', 17:06:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:45 INFO - 'tests': ['tp5n']}, 17:06:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:06:45 INFO - 'talos_options': ['--e10s', 17:06:45 INFO - '--xperf_path', 17:06:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:06:45 INFO - 'tests': ['tp5n']}}, 17:06:45 INFO - 'talos.zip': {'path': '', 17:06:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:06:45 INFO - Running post-action listener: _resource_record_post_action 17:06:45 INFO - ##### 17:06:45 INFO - ##### Running create-virtualenv step. 17:06:45 INFO - ##### 17:06:45 INFO - Running pre-action listener: _resource_record_pre_action 17:06:45 INFO - Running main action method: create_virtualenv 17:06:45 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 17:06:45 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 17:06:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 17:06:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:06:45 INFO - Using real prefix '/usr' 17:06:45 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 17:06:45 INFO - Installing distribute.............................................................................................................................................................................................done. 17:06:47 INFO - Installing pip.................done. 17:06:47 INFO - Return code: 0 17:06:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 17:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f60f4677f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb6350>, '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 0xfb7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb76e0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', '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 17:06:47 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 17:06:47 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 17:06:47 INFO - Using env: {'DISPLAY': ':0', 17:06:47 INFO - 'HOME': '/home/cltbld', 17:06:47 INFO - 'LANG': 'en_US.UTF-8', 17:06:47 INFO - 'LANGUAGE': 'en_US:en', 17:06:47 INFO - 'LOGNAME': 'cltbld', 17:06:47 INFO - 'MAIL': '/var/mail/cltbld', 17:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:47 INFO - 'MOZ_NO_REMOTE': '1', 17:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:47 INFO - 'NO_EM_RESTART': '1', 17:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:06:47 INFO - 'PWD': '/builds/slave/test-pgo', 17:06:47 INFO - 'SHELL': '/bin/bash', 17:06:47 INFO - 'SHLVL': '1', 17:06:47 INFO - 'TERM': 'linux', 17:06:47 INFO - 'TMOUT': '86400', 17:06:47 INFO - 'USER': 'cltbld', 17:06:47 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', 17:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:47 INFO - '_': '/tools/buildbot/bin/python'} 17:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:47 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 17:06:47 INFO - Cleaning up... 17:06:47 INFO - Return code: 0 17:06:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 17:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f60f4677f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb6350>, '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 0xfb7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb76e0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', '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 17:06:47 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 17:06:47 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 17:06:47 INFO - Using env: {'DISPLAY': ':0', 17:06:47 INFO - 'HOME': '/home/cltbld', 17:06:47 INFO - 'LANG': 'en_US.UTF-8', 17:06:47 INFO - 'LANGUAGE': 'en_US:en', 17:06:47 INFO - 'LOGNAME': 'cltbld', 17:06:47 INFO - 'MAIL': '/var/mail/cltbld', 17:06:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:47 INFO - 'MOZ_NO_REMOTE': '1', 17:06:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:47 INFO - 'NO_EM_RESTART': '1', 17:06:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:06:47 INFO - 'PWD': '/builds/slave/test-pgo', 17:06:47 INFO - 'SHELL': '/bin/bash', 17:06:47 INFO - 'SHLVL': '1', 17:06:47 INFO - 'TERM': 'linux', 17:06:47 INFO - 'TMOUT': '86400', 17:06:47 INFO - 'USER': 'cltbld', 17:06:47 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', 17:06:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:47 INFO - '_': '/tools/buildbot/bin/python'} 17:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:48 INFO - Downloading/unpacking psutil>=0.7.1 17:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:49 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 17:06:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:06:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 17:06:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:49 INFO - Installing collected packages: psutil 17:06:49 INFO - Running setup.py install for psutil 17:06:50 INFO - building 'psutil._psutil_linux' extension 17:06:50 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 17:06:50 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 17:06:50 INFO - building 'psutil._psutil_posix' extension 17:06:50 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 17:06:50 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 17:06:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:06:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:06:50 INFO - Successfully installed psutil 17:06:50 INFO - Cleaning up... 17:06:50 INFO - Return code: 0 17:06:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 17:06:50 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')]} 17:06:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:50 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')]} 17:06:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:50 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 0x7f60f4677f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb6350>, '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 0xfb7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb76e0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', '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 17:06:50 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 17:06:50 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 17:06:50 INFO - Using env: {'DISPLAY': ':0', 17:06:50 INFO - 'HOME': '/home/cltbld', 17:06:50 INFO - 'LANG': 'en_US.UTF-8', 17:06:50 INFO - 'LANGUAGE': 'en_US:en', 17:06:50 INFO - 'LOGNAME': 'cltbld', 17:06:50 INFO - 'MAIL': '/var/mail/cltbld', 17:06:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:50 INFO - 'MOZ_NO_REMOTE': '1', 17:06:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:50 INFO - 'NO_EM_RESTART': '1', 17:06:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:06:50 INFO - 'PWD': '/builds/slave/test-pgo', 17:06:50 INFO - 'SHELL': '/bin/bash', 17:06:50 INFO - 'SHLVL': '1', 17:06:50 INFO - 'TERM': 'linux', 17:06:50 INFO - 'TMOUT': '86400', 17:06:50 INFO - 'USER': 'cltbld', 17:06:50 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', 17:06:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:50 INFO - '_': '/tools/buildbot/bin/python'} 17:06:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:06:50 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 17:06:50 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 17:06:50 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 17:06:50 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 17:06:50 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 17:06:50 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 17:06:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:06:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:06:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:06:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:06:52 INFO - Installing collected packages: mozsystemmonitor 17:06:52 INFO - Running setup.py install for mozsystemmonitor 17:06:52 INFO - Successfully installed mozsystemmonitor 17:06:52 INFO - Cleaning up... 17:06:52 INFO - Return code: 0 17:06:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 17:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f60f4677f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb6350>, '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 0xfb7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb76e0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', '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 17:06:52 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 17:06:52 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 17:06:52 INFO - Using env: {'DISPLAY': ':0', 17:06:52 INFO - 'HOME': '/home/cltbld', 17:06:52 INFO - 'LANG': 'en_US.UTF-8', 17:06:52 INFO - 'LANGUAGE': 'en_US:en', 17:06:52 INFO - 'LOGNAME': 'cltbld', 17:06:52 INFO - 'MAIL': '/var/mail/cltbld', 17:06:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:52 INFO - 'MOZ_NO_REMOTE': '1', 17:06:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:52 INFO - 'NO_EM_RESTART': '1', 17:06:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:06:52 INFO - 'PWD': '/builds/slave/test-pgo', 17:06:52 INFO - 'SHELL': '/bin/bash', 17:06:52 INFO - 'SHLVL': '1', 17:06:52 INFO - 'TERM': 'linux', 17:06:52 INFO - 'TMOUT': '86400', 17:06:52 INFO - 'USER': 'cltbld', 17:06:52 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', 17:06:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:52 INFO - '_': '/tools/buildbot/bin/python'} 17:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:52 INFO - Downloading/unpacking blobuploader==1.2.4 17:06:52 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 17:06:52 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 17:06:52 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 17:06:52 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 17:06:52 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 17:06:52 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 17:06:54 INFO - Downloading blobuploader-1.2.4.tar.gz 17:06:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:06:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:06:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:06:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 17:06:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:06:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:06:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:06:55 INFO - Downloading docopt-0.6.1.tar.gz 17:06:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:06:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 17:06:55 INFO - Installing collected packages: blobuploader, requests, docopt 17:06:55 INFO - Running setup.py install for blobuploader 17:06:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:06:55 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 17:06:55 INFO - Running setup.py install for requests 17:06:56 INFO - Running setup.py install for docopt 17:06:56 INFO - Successfully installed blobuploader requests docopt 17:06:56 INFO - Cleaning up... 17:06:56 INFO - Return code: 0 17:06:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:56 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 0x7f60f4677f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb6350>, '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 0xfb7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb76e0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', '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 17:06:56 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 17:06:56 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 17:06:56 INFO - Using env: {'DISPLAY': ':0', 17:06:56 INFO - 'HOME': '/home/cltbld', 17:06:56 INFO - 'LANG': 'en_US.UTF-8', 17:06:56 INFO - 'LANGUAGE': 'en_US:en', 17:06:56 INFO - 'LOGNAME': 'cltbld', 17:06:56 INFO - 'MAIL': '/var/mail/cltbld', 17:06:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:56 INFO - 'MOZ_NO_REMOTE': '1', 17:06:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:56 INFO - 'NO_EM_RESTART': '1', 17:06:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:06:56 INFO - 'PWD': '/builds/slave/test-pgo', 17:06:56 INFO - 'SHELL': '/bin/bash', 17:06:56 INFO - 'SHLVL': '1', 17:06:56 INFO - 'TERM': 'linux', 17:06:56 INFO - 'TMOUT': '86400', 17:06:56 INFO - 'USER': 'cltbld', 17:06:56 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', 17:06:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:56 INFO - '_': '/tools/buildbot/bin/python'} 17:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:06:56 INFO - Running setup.py (path:/tmp/pip-Sfk7RD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:06:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:06:56 INFO - Running setup.py (path:/tmp/pip-U4INYP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:06:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:06:56 INFO - Running setup.py (path:/tmp/pip-Nd7xoM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:06:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:06:56 INFO - Running setup.py (path:/tmp/pip-HloLCg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:06:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:06:56 INFO - Running setup.py (path:/tmp/pip-aivSnY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:06:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:06:56 INFO - Running setup.py (path:/tmp/pip-4KK73V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:06:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:06:57 INFO - Running setup.py (path:/tmp/pip-ZGwVC1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:06:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:06:57 INFO - Running setup.py (path:/tmp/pip-BgovQf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:06:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:06:57 INFO - Running setup.py (path:/tmp/pip-gdUrFx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:06:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:06:57 INFO - Running setup.py (path:/tmp/pip-ISm_Ql-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:06:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:06:57 INFO - Running setup.py (path:/tmp/pip-WbMANg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:06:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:06:57 INFO - Running setup.py (path:/tmp/pip-1GN30q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:06:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:06:57 INFO - Running setup.py (path:/tmp/pip-bbdCUf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:06:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:06:57 INFO - Running setup.py (path:/tmp/pip-jq2tFE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:06:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:06:57 INFO - Running setup.py (path:/tmp/pip-qgYQuE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:06:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:06:57 INFO - Running setup.py (path:/tmp/pip-U2E_mt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:06:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:06:57 INFO - Running setup.py (path:/tmp/pip-TCBXFQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:06:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:06:57 INFO - Running setup.py install for manifestparser 17:06:57 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 17:06:57 INFO - Running setup.py install for mozcrash 17:06:58 INFO - Running setup.py install for mozdebug 17:06:58 INFO - Running setup.py install for mozdevice 17:06:58 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 17:06:58 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 17:06:58 INFO - Running setup.py install for mozfile 17:06:58 INFO - Running setup.py install for mozhttpd 17:06:58 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 17:06:58 INFO - Running setup.py install for mozinfo 17:06:58 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 17:06:58 INFO - Running setup.py install for mozInstall 17:06:58 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 17:06:58 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 17:06:58 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 17:06:58 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 17:06:58 INFO - Running setup.py install for mozleak 17:06:58 INFO - Running setup.py install for mozlog 17:06:58 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 17:06:58 INFO - Running setup.py install for moznetwork 17:06:58 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 17:06:58 INFO - Running setup.py install for mozprocess 17:06:59 INFO - Running setup.py install for mozprofile 17:06:59 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 17:06:59 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 17:06:59 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 17:06:59 INFO - Running setup.py install for mozrunner 17:06:59 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 17:06:59 INFO - Running setup.py install for mozscreenshot 17:06:59 INFO - Running setup.py install for moztest 17:06:59 INFO - Running setup.py install for mozversion 17:06:59 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 17:06:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:06:59 INFO - Cleaning up... 17:06:59 INFO - Return code: 0 17:06:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:06:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:06:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:06:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:06:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f60f4677f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb6350>, '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 0xfb7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb76e0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', '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 17:06:59 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 17:06:59 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 17:06:59 INFO - Using env: {'DISPLAY': ':0', 17:06:59 INFO - 'HOME': '/home/cltbld', 17:06:59 INFO - 'LANG': 'en_US.UTF-8', 17:06:59 INFO - 'LANGUAGE': 'en_US:en', 17:06:59 INFO - 'LOGNAME': 'cltbld', 17:06:59 INFO - 'MAIL': '/var/mail/cltbld', 17:06:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:06:59 INFO - 'MOZ_NO_REMOTE': '1', 17:06:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:06:59 INFO - 'NO_EM_RESTART': '1', 17:06:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:06:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:06:59 INFO - 'PWD': '/builds/slave/test-pgo', 17:06:59 INFO - 'SHELL': '/bin/bash', 17:06:59 INFO - 'SHLVL': '1', 17:06:59 INFO - 'TERM': 'linux', 17:06:59 INFO - 'TMOUT': '86400', 17:06:59 INFO - 'USER': 'cltbld', 17:06:59 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', 17:06:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:06:59 INFO - '_': '/tools/buildbot/bin/python'} 17:06:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:06:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:06:59 INFO - Running setup.py (path:/tmp/pip-nML5nQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 17:06:59 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)) 17:06:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:06:59 INFO - Running setup.py (path:/tmp/pip-4n38aF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 17:07:00 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)) 17:07:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:07:00 INFO - Running setup.py (path:/tmp/pip-SFDv1N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 17:07:00 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)) 17:07:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:07:00 INFO - Running setup.py (path:/tmp/pip-UHbCqB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 17:07:00 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)) 17:07:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 17:07:00 INFO - Running setup.py (path:/tmp/pip-LYIMlD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 17:07:00 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)) 17:07:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:07:00 INFO - Running setup.py (path:/tmp/pip-YSszKn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 17:07:00 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)) 17:07:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:07:00 INFO - Running setup.py (path:/tmp/pip-Zbdxek-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 17:07:00 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)) 17:07:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:07:00 INFO - Running setup.py (path:/tmp/pip-KKzX8L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 17:07:00 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)) 17:07:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 17:07:00 INFO - Running setup.py (path:/tmp/pip-vWeiR1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 17:07:00 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)) 17:07:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 17:07:00 INFO - Running setup.py (path:/tmp/pip-xBlckN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 17:07:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:07:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:07:00 INFO - Running setup.py (path:/tmp/pip-GtwLWC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 17:07:00 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)) 17:07:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:07:00 INFO - Running setup.py (path:/tmp/pip-y_hp28-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 17:07:00 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)) 17:07:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:07:00 INFO - Running setup.py (path:/tmp/pip-Jx9PbO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 17:07:00 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)) 17:07:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:07:00 INFO - Running setup.py (path:/tmp/pip-b7_sfK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 17:07:00 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)) 17:07:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:07:00 INFO - Running setup.py (path:/tmp/pip-GqCNSJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 17:07:00 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)) 17:07:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 17:07:00 INFO - Running setup.py (path:/tmp/pip-8bhHZf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 17:07:01 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)) 17:07:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 17:07:01 INFO - Running setup.py (path:/tmp/pip-pGSqPU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 17:07:01 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)) 17:07:01 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)) 17:07:01 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)) 17:07:01 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)) 17:07:01 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)) 17:07:01 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)) 17:07:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 17:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:02 INFO - Downloading blessings-1.5.1.tar.gz 17:07:02 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 17:07:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 17:07:02 INFO - Installing collected packages: blessings 17:07:02 INFO - Running setup.py install for blessings 17:07:03 INFO - Successfully installed blessings 17:07:03 INFO - Cleaning up... 17:07:03 INFO - Return code: 0 17:07:03 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 17:07:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:07:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:07:03 INFO - Reading from file tmpfile_stdout 17:07:03 INFO - Current package versions: 17:07:03 INFO - argparse == 1.2.1 17:07:03 INFO - blessings == 1.5.1 17:07:03 INFO - blobuploader == 1.2.4 17:07:03 INFO - docopt == 0.6.1 17:07:03 INFO - manifestparser == 1.1 17:07:03 INFO - mozInstall == 1.12 17:07:03 INFO - mozcrash == 0.16 17:07:03 INFO - mozdebug == 0.1 17:07:03 INFO - mozdevice == 0.47 17:07:03 INFO - mozfile == 1.2 17:07:03 INFO - mozhttpd == 0.7 17:07:03 INFO - mozinfo == 0.9 17:07:03 INFO - mozleak == 0.1 17:07:03 INFO - mozlog == 3.1 17:07:03 INFO - moznetwork == 0.27 17:07:03 INFO - mozprocess == 0.22 17:07:03 INFO - mozprofile == 0.27 17:07:03 INFO - mozrunner == 6.11 17:07:03 INFO - mozscreenshot == 0.1 17:07:03 INFO - mozsystemmonitor == 0.0 17:07:03 INFO - moztest == 0.7 17:07:03 INFO - mozversion == 1.4 17:07:03 INFO - psutil == 3.1.1 17:07:03 INFO - requests == 1.2.3 17:07:03 INFO - wsgiref == 0.1.2 17:07:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 17:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f60f4677f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb6350>, '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 0xfb7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb76e0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', '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 17:07:03 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 17:07:03 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 17:07:03 INFO - Using env: {'DISPLAY': ':0', 17:07:03 INFO - 'HOME': '/home/cltbld', 17:07:03 INFO - 'LANG': 'en_US.UTF-8', 17:07:03 INFO - 'LANGUAGE': 'en_US:en', 17:07:03 INFO - 'LOGNAME': 'cltbld', 17:07:03 INFO - 'MAIL': '/var/mail/cltbld', 17:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:03 INFO - 'MOZ_NO_REMOTE': '1', 17:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:03 INFO - 'NO_EM_RESTART': '1', 17:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:07:03 INFO - 'PWD': '/builds/slave/test-pgo', 17:07:03 INFO - 'SHELL': '/bin/bash', 17:07:03 INFO - 'SHLVL': '1', 17:07:03 INFO - 'TERM': 'linux', 17:07:03 INFO - 'TMOUT': '86400', 17:07:03 INFO - 'USER': 'cltbld', 17:07:03 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', 17:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:03 INFO - '_': '/tools/buildbot/bin/python'} 17:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:03 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)) 17:07:03 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)) 17:07:03 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)) 17:07:03 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)) 17:07:03 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)) 17:07:03 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)) 17:07:03 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)) 17:07:03 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)) 17:07:03 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)) 17:07:03 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)) 17:07:03 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)) 17:07:03 INFO - Cleaning up... 17:07:03 INFO - Return code: 0 17:07:03 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 17:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:07:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f60f4677f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb6350>, '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 0xfb7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb76e0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', '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 17:07:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 17:07:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:07:03 INFO - Using env: {'DISPLAY': ':0', 17:07:03 INFO - 'HOME': '/home/cltbld', 17:07:03 INFO - 'LANG': 'en_US.UTF-8', 17:07:03 INFO - 'LANGUAGE': 'en_US:en', 17:07:03 INFO - 'LOGNAME': 'cltbld', 17:07:03 INFO - 'MAIL': '/var/mail/cltbld', 17:07:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:03 INFO - 'MOZ_NO_REMOTE': '1', 17:07:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:03 INFO - 'NO_EM_RESTART': '1', 17:07:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:07:03 INFO - 'PWD': '/builds/slave/test-pgo', 17:07:03 INFO - 'SHELL': '/bin/bash', 17:07:03 INFO - 'SHLVL': '1', 17:07:03 INFO - 'TERM': 'linux', 17:07:03 INFO - 'TMOUT': '86400', 17:07:03 INFO - 'USER': 'cltbld', 17:07:03 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', 17:07:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:03 INFO - '_': '/tools/buildbot/bin/python'} 17:07:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:03 INFO - Downloading/unpacking jsonschema 17:07:03 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 17:07:03 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 17:07:03 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 17:07:03 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 17:07:03 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 17:07:03 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 17:07:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:07:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 17:07:05 INFO - Downloading/unpacking functools32 (from jsonschema) 17:07:05 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 17:07:05 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 17:07:05 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 17:07:05 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 17:07:05 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 17:07:05 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 17:07:05 INFO - Downloading functools32-3.2.3-2.tar.gz 17:07:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:07:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 17:07:05 INFO - warning: no files found matching '*.txt' 17:07:05 INFO - no previously-included directories found matching 'build' 17:07:05 INFO - no previously-included directories found matching 'dist' 17:07:05 INFO - no previously-included directories found matching '.git*' 17:07:05 INFO - Installing collected packages: jsonschema, functools32 17:07:05 INFO - Running setup.py install for functools32 17:07:05 INFO - warning: no files found matching '*.txt' 17:07:05 INFO - no previously-included directories found matching 'build' 17:07:05 INFO - no previously-included directories found matching 'dist' 17:07:05 INFO - no previously-included directories found matching '.git*' 17:07:05 INFO - Successfully installed jsonschema functools32 17:07:05 INFO - Cleaning up... 17:07:05 INFO - Return code: 0 17:07:05 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 17:07:05 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')]} 17:07:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:07:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:05 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')]} 17:07:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:07:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:07:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f60f4677f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf27600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfb6350>, '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 0xfb7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb76e0>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', '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 17:07:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 17:07:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:07:05 INFO - Using env: {'DISPLAY': ':0', 17:07:05 INFO - 'HOME': '/home/cltbld', 17:07:05 INFO - 'LANG': 'en_US.UTF-8', 17:07:05 INFO - 'LANGUAGE': 'en_US:en', 17:07:05 INFO - 'LOGNAME': 'cltbld', 17:07:05 INFO - 'MAIL': '/var/mail/cltbld', 17:07:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:05 INFO - 'MOZ_NO_REMOTE': '1', 17:07:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:05 INFO - 'NO_EM_RESTART': '1', 17:07:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:07:05 INFO - 'PWD': '/builds/slave/test-pgo', 17:07:05 INFO - 'SHELL': '/bin/bash', 17:07:05 INFO - 'SHLVL': '1', 17:07:05 INFO - 'TERM': 'linux', 17:07:05 INFO - 'TMOUT': '86400', 17:07:05 INFO - 'USER': 'cltbld', 17:07:05 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', 17:07:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:05 INFO - '_': '/tools/buildbot/bin/python'} 17:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:07:06 INFO - Downloading/unpacking flake8 17:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:07 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:07:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 17:07:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:07:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 17:07:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 17:07:08 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:07:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:07:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:07:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:07:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 17:07:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:07:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:07:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:07:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:07:08 INFO - no previously-included directories found matching 'docs/_build' 17:07:08 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:07:08 INFO - Running setup.py install for pep8 17:07:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:07:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:07:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:07:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:07:08 INFO - no previously-included directories found matching 'docs/_build' 17:07:08 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 17:07:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:07:08 INFO - Cleaning up... 17:07:08 INFO - Return code: 0 17:07:08 INFO - Running post-action listener: _resource_record_post_action 17:07:08 INFO - Running post-action listener: _start_resource_monitoring 17:07:08 INFO - Starting resource monitoring. 17:07:08 INFO - ##### 17:07:08 INFO - ##### Running install step. 17:07:08 INFO - ##### 17:07:08 INFO - Running pre-action listener: _resource_record_pre_action 17:07:08 INFO - Running main action method: install 17:07:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 17:07:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 17:07:08 INFO - Reading from file tmpfile_stdout 17:07:08 INFO - Detecting whether we're running mozinstall >=1.0... 17:07:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 17:07:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 17:07:09 INFO - Reading from file tmpfile_stdout 17:07:09 INFO - Output received: 17:07:09 INFO - Usage: mozinstall [options] installer 17:07:09 INFO - Options: 17:07:09 INFO - -h, --help show this help message and exit 17:07:09 INFO - -d DEST, --destination=DEST 17:07:09 INFO - Directory to install application into. [default: 17:07:09 INFO - "/builds/slave/test-pgo"] 17:07:09 INFO - --app=APP Application being installed. [default: firefox] 17:07:09 INFO - mkdir: /builds/slave/test-pgo/build/application 17:07:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 17:07:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 17:07:24 INFO - Reading from file tmpfile_stdout 17:07:24 INFO - Output received: 17:07:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 17:07:24 INFO - Running post-action listener: _resource_record_post_action 17:07:24 INFO - ##### 17:07:24 INFO - ##### Running run-tests step. 17:07:24 INFO - ##### 17:07:24 INFO - Running pre-action listener: _resource_record_pre_action 17:07:24 INFO - Running main action method: run_tests 17:07:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 17:07:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 17:07:24 INFO - Python 2.7.3 17:07:24 INFO - Return code: 0 17:07:24 INFO - grabbing minidump binary from tooltool 17:07: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')]} 17:07:24 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 0xfb6350>, '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 0xfb7250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfb76e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 17:07:24 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 17:07:24 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 17:07:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:07:24 INFO - Return code: 0 17:07:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 17:07:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 17:07:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 17:07:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 17:07:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 17:07:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 17:07:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 17:07:25 INFO - Return code: 0 17:07:25 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/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 17:07:25 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/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost 17:07:25 INFO - Using env: {'DISPLAY': ':0', 17:07:25 INFO - 'HOME': '/home/cltbld', 17:07:25 INFO - 'LANG': 'en_US.UTF-8', 17:07:25 INFO - 'LANGUAGE': 'en_US:en', 17:07:25 INFO - 'LOGNAME': 'cltbld', 17:07:25 INFO - 'MAIL': '/var/mail/cltbld', 17:07:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:07:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 17:07:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:07:25 INFO - 'MOZ_NO_REMOTE': '1', 17:07:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 17:07:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:07:25 INFO - 'NO_EM_RESTART': '1', 17:07:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:07:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 17:07:25 INFO - 'PWD': '/builds/slave/test-pgo', 17:07:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 17:07:25 INFO - 'SHELL': '/bin/bash', 17:07:25 INFO - 'SHLVL': '1', 17:07:25 INFO - 'TERM': 'linux', 17:07:25 INFO - 'TMOUT': '86400', 17:07:25 INFO - 'USER': 'cltbld', 17:07:25 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758', 17:07:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:07:25 INFO - '_': '/tools/buildbot/bin/python'} 17:07:25 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/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost'] with output_timeout 3600 17:07:25 INFO - mozversion INFO | application_buildid: 20151218143005 17:07:25 INFO - mozversion INFO | application_changeset: 51a5ff26043b41027d4e32aaf16f93dfe0ec17b8 17:07:25 INFO - mozversion INFO | application_display_name: Nightly 17:07:25 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:07:25 INFO - mozversion INFO | application_name: Firefox 17:07:25 INFO - mozversion INFO | application_remotingname: firefox 17:07:25 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 17:07:25 INFO - mozversion INFO | application_vendor: Mozilla 17:07:25 INFO - mozversion INFO | application_version: 46.0a1 17:07:25 INFO - mozversion INFO | platform_buildid: 20151218143005 17:07:25 INFO - mozversion INFO | platform_changeset: 51a5ff26043b41027d4e32aaf16f93dfe0ec17b8 17:07:25 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 17:07:25 INFO - mozversion INFO | platform_version: 46.0a1 17:07:25 INFO - 2015-12-18 17:07:25,943 DEBUG : using testdate: 1450487245 17:07:25 INFO - 2015-12-18 17:07:25,943 DEBUG : actual date: 1450487245 17:07:25 INFO - 2015-12-18 17:07:25,952 INFO : starting webserver on 'localhost:49450' 17:07:25 INFO - 2015-12-18 17:07:25,953 INFO : Starting test suite talos-linux64-ix-062 17:07:25 INFO - 2015-12-18 17:07:25,953 INFO : Starting test dromaeo_css 17:07:25 INFO - 2015-12-18 17:07:25,953 DEBUG : operating with platform_type : linux_ 17:07:25 INFO - 2015-12-18 17:07:25,954 INFO : Initialising browser for dromaeo_css test... 17:07:25 INFO - 2015-12-18 17:07:25,970 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgznpd4/profile http://localhost:49450/getInfo.html 17:07:30 INFO - 2015-12-18 17:07:30,193 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:07:30 INFO - 2015-12-18 17:07:30,193 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:07:30 INFO - 2015-12-18 17:07:30,193 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:07:30 INFO - 2015-12-18 17:07:30,193 DEBUG : BROWSER_OUTPUT: __metrics 17:07:30 INFO - 2015-12-18 17:07:30,310 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:07:30 INFO - 2015-12-18 17:07:30,353 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:07:30 ERROR - 2015-12-18 17:07:30,369 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 17:07:31 INFO - 2015-12-18 17:07:31,139 INFO : Browser initialized. 17:07:31 INFO - 2015-12-18 17:07:31,140 INFO : Running cycle 1/1 for dromaeo_css test... 17:07:31 INFO - 2015-12-18 17:07:31,140 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgznpd4/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:07:42 INFO - 2015-12-18 17:07:42,943 DEBUG : BROWSER_OUTPUT: RSS: Main: 149602304 17:07:42 INFO - 2015-12-18 17:07:42,944 DEBUG : BROWSER_OUTPUT: 17:08:34 INFO - 2015-12-18 17:08:34,440 DEBUG : BROWSER_OUTPUT: 1450487314438 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] 17:10:42 INFO - 2015-12-18 17:10:42,285 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49450/tests/dromaeo/cssquery-ext.html) 17:10:44 INFO - 2015-12-18 17:10:44,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 357793792 17:10:44 INFO - 2015-12-18 17:10:44,219 DEBUG : BROWSER_OUTPUT: 17:13:46 INFO - 2015-12-18 17:13:46,739 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-ext.html (next: http://localhost:49450/tests/dromaeo/cssquery-jquery.html) 17:13:47 INFO - 2015-12-18 17:13:47,304 DEBUG : BROWSER_OUTPUT: RSS: Main: 237187072 17:13:47 INFO - 2015-12-18 17:13:47,304 DEBUG : BROWSER_OUTPUT: 17:16:49 INFO - 2015-12-18 17:16:49,240 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49450/tests/dromaeo/cssquery-mootools.html) 17:16:49 INFO - 2015-12-18 17:16:49,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 227594240 17:16:49 INFO - 2015-12-18 17:16:49,822 DEBUG : BROWSER_OUTPUT: 17:19:51 INFO - 2015-12-18 17:19:51,714 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49450/tests/dromaeo/cssquery-prototype.html) 17:19:52 INFO - 2015-12-18 17:19:52,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 213819392 17:19:52 INFO - 2015-12-18 17:19:52,283 DEBUG : BROWSER_OUTPUT: 17:22:54 INFO - 2015-12-18 17:22:54,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49450/tests/dromaeo/cssquery-yui.html) 17:22:55 INFO - 2015-12-18 17:22:55,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 216666112 17:22:55 INFO - 2015-12-18 17:22:55,428 DEBUG : BROWSER_OUTPUT: 17:25:58 INFO - 2015-12-18 17:25:58,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/dromaeo/cssquery-yui.html (next: http://localhost:49450/tests/dromaeo/cssquery-dojo.html) 17:25:58 INFO - 2015-12-18 17:25:58,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 265056256 17:25:58 INFO - 2015-12-18 17:25:58,275 DEBUG : BROWSER_OUTPUT: 17:25:58 INFO - 2015-12-18 17:25:58,276 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:25:58 INFO - 2015-12-18 17:25:58,276 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:25:58 INFO - 2015-12-18 17:25:58,276 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:25:58 INFO - 2015-12-18 17:25:58,276 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:25:58 INFO - 2015-12-18 17:25:58,278 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3066.677998810125;3120.2199450137464;3145.3866496033256;3154.747620190385;3181.0933883843104;5106.361704786902;5252.47475252475;5264.868378290545;5267.130923397634;5285.6300058995885;5179.637425380225;5247.291615631889;5260.132078207101;5386.165144402614;5423.403425623178;4807;4816.277558366256;4851.27230915362;4865.391826021747;4883.438404583465;4882.096812089757;4912.21404575268;4922.655414121013;4966.751662416883;4993.350864387625;4696.835610753607;4719.740414277213;4796.184648609745;4826.058918510892;4831.347768051303;4768.642351823592;4794.041191761627;4833.057553777015;4837.540433658797;4879.8780030499165;4747.667663263573;4770.952290477086;4783.28250762385;4798.4001999750035;4846.0550192712435;4946.851594452136;5039.395272567315;5039.496050394968;5093.083245015896;5170.146925757245;5713.714314284311;5719.7140142992685;5729.427057294237;5729.684867332295;5737.3975732548315;5742.08126699726;5745.2243947067445;5748.913766293509;5749.367569567345;5778.335491418498;5175.171972484384;5282.181261904411;5286.762095705664;5361.249425080492;5403.621746477748;5769.653820770767;5772.826815195467;5791.362950075489;5799.623024503394;5825.79609713658;5484.588655850827;5559.166125081189;5571.860703482364;5573.804916827891;5608;5629.4652008059165;5667.036603777367;5701.71491425427;5778.133280008033;5837.445442682938;5630.690312032795;5634.1830434586755;5660.490555849911;5663.80176693822;5666.4050274721385;5485.670859748428;5622.325320961429;5643.463870932255;5660.235868157828;5673.914891276634;4371.912561748811;4397.978010109929;4434.357018232338;4445.666575006888;4476.843310484118;3909.980450097731;3911.3155197840265;3914.921701565953;3951.703622228287;3959.7228194026716;5243.23973023917;5346.572274218053;5353.491418315254;5353.785848566092;5356.517913387814;5634.126710359901;5673.262475878192;5703.686297253691;5707.229524014288;5744.856378590569;5336.893262134736;5340.385855626652;5341.305630268041;5361.731913404315;5362.27609272751;4808.134535783523;4893.363862697826;4912.680675756064;4925.5074492551175;4998.525140111684;5822.214001109796;5852.326982397079;5853.619514731528;5856.443637854397;5859.941400586024;5690;5690.231818704422;5710.114932185518;5710.971445142914;5725.255716756795;5607.663540187602;5689.061304884648;5740.196372507936;5826.912596310974;5854.209681693087;5596.244506991504;5608.4111168326735;5610.018246806874;5615.831525054255;5616.185653080199;5633.2395126657375;5684.403137670485;5691.544676425793;5695.288088988877;5700.372958974593;5533.253010843646;5533.280673512418;5539.307586551681;5540.833774986757;5568.582356323211;5474.260974768515;5560.388357280615;5595.8880822384135;5608.859778505407;5612.663240205601;5498.5876059294915;5509.5041446270025;5511.586631002771;5512.944870551243;5513.669179849222;5614.9719251403485;5629.7748090077575;5629.802956896489;5638.182463542681;5645.350784659652;5265.52610265078;5308.893822123613;5313.681179129265;5335.226392173191;5339.25250464943 17:25:58 INFO - 2015-12-18 17:25:58,281 DEBUG : BROWSER_OUTPUT: |1;ext.html;544.9996284093442;592.7184587321022;601.8344955137339;602.82819396472;613.742228264129;30474.847625761897;31094;31095.689043109563;31157.844210778916;38626.227475450476;43079.78460107703;43689.34465983005;43777.56222437775;43817;43874;8584.313254939621;8821.51481668508;8836.955815220916;8839.51382673956;8844.823103537925;7741.264579864932;7896.091949425803;7904.170062143478;8602.569871506432;8707.912920870773;10415.323004004753;10680.198985076111;10707.892921070768;10734.463276836166;10769.138468922467;10303.742406439862;10358;10428.165746740242;10447.42539160346;10456.372617642928;7681.846363072763;7831.608419579055;7847;10233.795324093551;10381.480925953672;43124.35313470301;44243.77878110621;44244.778776106235;44276.3358549622;44304;3355.2115252915546;3361.46216605342;3390.440577304742;3423.3153369325987;3527.9647203528148;29759.553606695918;29898.85050574755;30269.24326891823;30847.845760771277;31463.84268078645;3748.250349929998;3774.2262836118803;3837.3092843288196;3852.672522835562;3876.2247550490015;264508;268353;268381;268517;269124.6543767288;61994;62151.067733984026;62416.37583624196;62427.375726243066;62439.75120497565;65785.67107164433;65817;65958.34041659618;66002;66036.66981665157;15034.248287585577;15254.923725381303;15407.306671199824;15439.536813895602;15457.458988935557;11104.500297486633;11118.722031949104;11121.833172502418;11127.554897803997;11139.498722557504;19410;20377.79622203759;20459.28392506285;20507.69238461424;20596;8020;8143.470674406263;8172.223638754309;8224.259816616533;8320.875186872201;923.6859467780987;950.1875896108866;955.159459675495;1026.6542885653164;1045.3414348960107;28604.570931436047;28637.711302991414;28778.424431511252;29087;29124.563131553045;946.9810603787886;1009.8939611340703;1023.3297190340339;1041.2555023158477;1058.7760269977937;13605.31973401326;13849.515266965607;13852.307384630729;16497.340106395848;17179.31282748701;369866;375380;375482;375492;377070;54814.177787333225;54874.17688734672;55123.44876551183;55137.172942405894;55506.44493555013;1351.439152751597;1362.9182249065088;1370.6847425092085;1378.1248906944163;1482.0070552729696;29470.263243418227;30515;31686;32931.83534082314;33060.83469582733;50123;50523.74738126286;50699.493005069475;50722;50784;301582;301621;301912;302944;303677;38673.41989870098;39412.60587394204;45293.32060019037;45377.77311113424;45987.31019034784;40665;40703.59296406998;41240.38139427971;42056;42315.788421057696;33925;35982;36494.4525832118;36685;37212;40598.797006015964;41677.79161104175;41768.164636707705;42046.78976605098;42750.572494275904;32910.83544582358;33446.832765836014;40481.19037619172;40700.796496017334;40949.795251023555;33114.33771324608;37311.44032839564;37541.81229093837;37775.81112094422;38048.239035219696;24365.147219847222;24597.87701061555;24721;24903.37741556403;24923.376915577257 17:25:58 INFO - 2015-12-18 17:25:58,283 DEBUG : BROWSER_OUTPUT: |2;jquery.html;360.69701450781355;366.19071851208827;366.25649930640793;367.98528058877645;370.89800304916145;13522.391492382842;13618.659533511667;16188.757168642465;16271;16658;13506.18962862229;13979.720405591883;16093.195340233;16434.75347869783;16524.917375413104;5291.920621190685;5388.676679399248;5405.189221616769;5420.7018613976215;5432.320959880015;3740.4576336431337;3819.083419979213;5283.339582552181;5324.068288049595;5491.423400542945;5319.680819150844;5508.338999320087;5516.724163791814;5525.668459892399;5535.308086489189;5394.32570928632;5496.7526461309135;5503.834884953438;5847.152162936351;5858.76564937402;5248.895022099537;5266.947330526722;5273.393559740641;5274.208868669692;5278.049951008817;12910.160839545399;13297.468101275937;18256.817431825646;20717.685170372817;20760;2044.2640649366217;2049.7847725988854;2087.4676957375773;2107.346722516025;2170.9240176593903;9135.634574617008;9305.674301399418;9346.15884570392;9581.616735330648;11083.556657733681;1783.9514174885044;1809.94570162894;1815.8456531194731;1830.7162389829464;1852.129499135404;61336.5880389571;66034.33965660378;66102;66186.66906665484;66451;10211.540480678239;10254.53854576546;10288.537015834305;10344.275900687031;10396.16830653546;13490.39293231807;13568.457261709618;13593.824988001872;13596.912247020215;13601.183928964294;7441.702331906663;7514.39884809214;7525.548467091992;7558.26159983196;7576.848463030708;7140.892886606705;7149.0706208192605;7165.426765858719;7190.604516751524;7257.673404696801;4386.1447017831215;4441.333799930037;4447.488538818013;4468.687191896601;4469.821207151743;1722.922468488921;1747.074050753103;1767.5492749349091;1830.9908450457663;1858.2845604442116;869.7043005378201;927.1840780113457;1002.5037606384886;1011.8836333821705;1063.6968463987725;16914.238859251363;17075.829241707674;17429.47711568655;17638.559036023944;17666.911665441592;775.4378075895044;889.2441424788877;914.7530166854912;924.2698268368049;942.5240253671852;9083.863742043875;9229.953850230706;9360.859587106199;9449.43303401798;9867.259955503367;528990;529393;538812;545566;546878;79318;80647.59676201582;81334.59332703298;83285.58357208296;84395;1158.5771193514306;1165.6561314412268;1223.6023292429995;1232.2336354883344;1248.2697621891114;15676.52970410844;15848.049117053013;16016.839831602001;16040.197990100682;16130.193490325672;36161.81919090388;36770.816145919096;36917.26165476729;37335;37470.87587372383;47014.529854702385;47566.28650570175;48936.26595600998;49126.50873491362;50353.244701330244;9087.091290871125;9236.907630923604;9498.430094194371;9581.089796469325;9824.852627210741;16313.755293670367;17313.52835008988;17859.910700446413;17893.910530447265;18026.09869506493;13300.40148193353;13519.526816561372;14671.92664036673;14954.252287385805;14984.100953942798;14399.568012959628;14624.976251662707;14634.34145463478;14997.850021499646;15263.389464421743;15126.39494420211;15148.924255378653;15275.618109546906;15608.687826243638;15746.133962632166;9374.765630859283;9387.389819661701;9489.240860730986;9496.952515237655;9510.667126650811;10567;10686.625968091079;13716.588502344946;14131.657492538192;15107.093574385572 17:25:58 INFO - 2015-12-18 17:25:58,284 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1281.6988007818168;1658.9253483593236;1672.665466906619;1696.9745453818186;1699.9660006799863;6438.163038804954;7114.395276401506;7327.303906128923;7344.118705755303;7344.4491663125345;7234.421246300297;7339.045924029882;7397.408207343413;7398.297161769623;7418.629068546565;1956.6184594004176;2006.3479369204995;2010.3566858605252;2157.7842215778455;2205.4376134085787;1801.0274451796015;2136.903839327234;2168.533765240473;2175.9347219583437;2180.1933284684687;2069.244725675125;2104.410764985799;2113.1124927530395;2113.524456997171;2161.7513985891587;2179.7384313882358;2204.603171429142;2206.646936490154;2209.458682622768;2211.524522227721;2192.78072192781;2233.3411643565187;2236.1167338901205;2247.4718441166315;2248.7413947396094;6917.827054323632;6934.757283495053;6992.720291188397;6998.475114366392;7003.054587630707;4514.593686568224;4568.109218702354;4595.333676616905;4607.124646317223;4609.755366051148;2946.484365236075;2998.415309014743;3072.8924487642826;3074.047045415928;3076.4616192166504;979.6571200079986;983.8917719050899;988.0662773678877;1018.1752780248023;1072;9943.5028248588;9946;9948.90051099487;9956.651517196864;9970.052844979715;4113.25961326964;4114.670826333886;4156.189543039139;4162.167566486714;4173.728707633994;8520.786980325542;8534.53060081689;8545.188207120314;8558.700445484377;8559.315254779603;4575.771211439414;4613.2388155953895;4616;4619.930701039487;4624.05206932578;4200.15996800635;4227.260229459832;4230.640395566411;4231.111466591989;4234.576542345741;3142.245860993391;3504.369213541536;3512.8946131616094;3516.0506663201304;3552.7335449841366;1034.5654824973528;1115.9218854680257;1162.128403697227;1163.0172504233908;1171.8183681529376;1035.1873779083382;1037.0355569320604;1097.7036200225893;1216.385725208764;1336.3251557963167;6938.028675985366;6979.651017449107;6991.93008069923;6999.30006999296;7004.2645522220455;1093.4860615510697;1102.729831191347;1117.6255954255416;1134.5688638317386;1139.481535901163;5495.2856128703015;5577.3028371453565;5611.523020543218;5615.859603509945;5619.662820230799;8171.836563268701;8197.180281971874;8198.057223419264;8294.8341033179;8321.126281740451;8083.878741818878;8171.836563268701;8228;8248.917510824935;8356.540390278593;6950.687219075154;6989.965050174818;6997.755078572327;7006.859862802818;7066.470014748812;6679.4990375721045;6766.289539598468;6804.4216241620015;6856.622885741132;6858;7815.491993020435;7883.7240696575345;7888.2506161914525;8022.759317220492;8045.557494337868;8022.0373555173755;8055.879161812461;8199.71301004462;8224.136465671018;8274.544900030556;6415.615063096229;6419.903701444388;6474.1907261592305;6474.223093228843;6477;6221.47117495018;6593.670316484253;7131.643417829192;7202.099737532809;7270.9636451817405;6623.238327592196;6675.933240667531;6736.629485378156;6808.897866532105;6883.7590684325805;6645.1361323027695;6674.132362792806;6687.899681504684;6695.230048544479;6702.463802895659;6746;6767.323267673193;6771.52599318043;6783;6814.829629259309;6329.208848893888;6403.935960640334;6413.615183089029;6415.743370265323;6420.454261387835;6285.654289014148;6388.4569811566535;6388.840278992877;6389.2652344980925;6405.167328247298 17:25:58 INFO - 2015-12-18 17:25:58,288 DEBUG : BROWSER_OUTPUT: |4;prototype.html;325.7833540695437;329.7872871997562;340.68486649848893;341.45196958881013;345.0820816627769;5919.08254220596;5922.585419020665;5956.01725715257;5964.671943043131;6033.818985430444;5637.605367624268;5685.118806584976;5810.535157187415;5820.912686309698;5903.380145084769;4571.565701258383;4594.793234304448;4600.861974140781;4611.239145540982;4617.861464156081;4400.669949753766;4619.53804619537;4624.491305956342;4625.79183936722;4634.142683603527;4383.890402739941;4464.910701785979;4505.504394516601;4520;4524.547545245482;4495.955040449587;4522.479914809806;4523.185826551219;4529.026259354222;4530.546945305476;3954.070793363586;3971.245463361981;3973.284808734427;3973.324534829086;3980.144268982183;5548.889022219573;5566.972165139189;5609.35492418373;5644.774209031634;5665.575081868877;5310.654807437504;5316.9202461963105;5320.467953204648;5324.148136298212;5329.546988505982;6222.222222222223;6256.311805701369;6258.937410625881;6264.5301602380005;6285.87428251437;4469.217886869785;4475.910481790378;4479.865604031885;4482.081173359454;4498.527654596286;6388.329225431309;6535.803925882231;6550.508711846631;6552.803415897531;6557.573757705782;4539.614132798749;4549.567791059844;4549.681522293474;4552.499225085238;4560.065186636798;4585.449746030497;4592.173408786383;4592.517785632527;4594.724316541018;4595.793189306489;5279.815206467755;5288.576913846883;5298.841034768886;5306.54894333986;5309.761060752276;6145.5698101133385;6347.1114044033875;6359.300476947532;6367.331430199855;6371.458426033839;1562.640592663671;1578.9578877940505;1579.241963857355;1581.6599431122363;1586.8889177757676;1046.3774054437597;1074.7152004718755;1079.5519859258477;1082.99458502707;1105.1324710102692;6062.545309101835;6084.056971169387;6087.908681369783;6093.177421048191;6110.969445152746;6542.149520562297;6548.607083574905;6549.443297319781;6550.803475895731;6558.80323590293;5902.085176797603;5982.670953097621;6066.848328791815;6089.360617135137;6099.9390006099375;3523.295340931824;3540.7521473497122;3557.5908770491205;3561.0385195996937;3561.0919215600375;6434;6584.176977877765;6704.530682852153;6705.7652982146365;6708.6310252936555;6537.411632953057;6721.361470660279;6726.764563240263;6728.629925354153;6755.088063111417;6699.564528305645;6707.3292670732535;6719.0593316935665;6720.798376048726;6720.932790672128;6461.515386345949;6598.637074960923;6601.306862779339;6601.834954126185;6613.570117942319;6469.611823290617;6483.740650373932;6484;6493.707783149675;6514.6416947068365;6713.395794378529;6714.3957043866285;6714.429273511806;6718.294579069323;6719.697613607497;4433.069055498381;4530.093981203707;4537.0472200836875;4537.342085397665;4552.88617784558;6553.082568440327;6578.5395022347975;6578.967105164444;6586.110875031809;6591.406773390418;6416.743330266737;6417.711202995783;6421.357864213542;6434;6447.387498187664;6222.62664240147;6364.459020983269;6406.615603063831;6410.967945160244;6435.09908612804;6239.812805615838;6250.718717657807;6296.590721603265;6336.3030066693545;6338.619682819046;6465.676716164267;6472.35276472349;6473.870522589427;6476.740930362733;6479.546431749733;6124.877502449837;6305.1172835803945;6313.147725057059;6321.557490975588;6322 17:25:58 INFO - 2015-12-18 17:25:58,289 DEBUG : BROWSER_OUTPUT: |5;yui.html;744.1999850161075;746.1009483572296;752.7440670172141;767.3554214459853;844.6916875340501;13974.301284935751;14202.715945681093;14227.359768810402;14249.71500569988;14252.144871307728;13217.273049982246;13242.073054886161;13273.20360778354;13289.534866279682;13349.733005339887;680.8161796314992;686.0840777561936;801.7594721583516;818.5170749257936;819.5983967855767;823.5347028928636;827.4580150001758;833.529056083314;833.9041010283835;836.1596595421623;710.9573425594481;857.4426622695236;866.3026263857623;867.7700409391484;868.622149365025;696.6029363262942;703.1702590942685;705.3510770091502;840.8276303357796;856.1737922904427;629.1694962649304;631.084926856056;634.0204384226381;634.1787385336;636.9554131210817;12347.38263086842;12373.381330933418;12394.380280986004;12396.13227074105;12437.191582547106;12007.3395963222;12017.39913004355;12175.33035683046;12234.510619575207;12281.69295767604;9432.622695092188;9628.759281017961;10003.39979601219;10016.38356464536;10166.288359814816;3481.331237261152;3576.946345804815;3582.677559019675;3644.908877278063;3676.9448458273146;44269.11461770746;44372.556274437164;44534.331985019926;44663.77668111671;44730.32904506403;9275.67535136267;9647.855282170773;9801;9885.50572471388;10418.739531511774;18148.092595370177;18286;18311.54221144482;18502.629947400976;18546.350877719215;7397.741079062314;7452.329290363893;7629.122650895218;7677.884831727529;7830.6084695764985;4197.937030944478;4259.2759230930815;4274.20927128476;4277.807498662568;4365.563443655609;3057.7095175958248;3084.6606873243927;3090.196548897303;3090.969090309113;3097.7521798256084;570.164708701754;576.5290174695211;578.254052272572;591.0779184472237;604.7399618164144;661.6191262647866;691.2016620802981;692.9514933954675;693.2512290807925;709.0109297529917;8991.82016359669;9065.864012039825;9082.818343633091;9389;9517.524123793783;621.9626822390671;630.196499463179;681.5331497923938;684.7945616315086;703.2088899987514;3593.299306635181;3634.927301454009;4044.5348784889525;4153.502006319028;4159.563245859202;50776;51296;51814.740926295126;52029;52421.47578524242;47903.5209647899;48327.27509087366;48830.51169488331;48846.755766220944;49272.75363623231;44571.77714111473;44651.77674111609;44802;45075.54924450779;46117.385891494305;7618.276263754934;7738.2261773822165;7754.291487699064;7773.883391749016;7779.144294127755;33614;35014.47478287879;35877.82061089678;36788.44817327688;37451.81274093612;42754.358684620376;43502.34746478868;43895.34156987584;44081;44270.557294426646;10733.302335348177;11026.44867756625;11040.171987100839;11196;11276.758218997084;11882.524699011943;12325.568605098779;12356.25862448256;12382.442790074649;13470.93264533671;11296.177344905485;11433.542658293574;11589.768204636028;11774.352410617155;12302.507899683913;11282.492287846902;11576.421178941187;11645.825312620149;11716;11944.462499187384;10877.857824928586;11009.394483303495;11550.249233799776;11656.708582285512;11970.042396608425;9116.361854670375;9423.340366174301;9494.525273736148;9581.751322909493;9618;9061;9084.954575227346;9574.377665451724;9578.329516933747;9592.328537002342 17:25:58 INFO - 2015-12-18 17:25:58,289 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:25:58 INFO - 2015-12-18 17:25:58,290 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:25:58 INFO - 2015-12-18 17:25:58,290 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1732 17:25:58 INFO - 2015-12-18 17:25:58,290 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:25:58 INFO - 2015-12-18 17:25:58,290 DEBUG : BROWSER_OUTPUT: __startTimestamp1450488358274__endTimestamp 17:25:58 INFO - 2015-12-18 17:25:58,291 DEBUG : BROWSER_OUTPUT: 17:25:58 INFO - 2015-12-18 17:25:58,291 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:25:58 INFO - 2015-12-18 17:25:58,291 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:25:58 INFO - 2015-12-18 17:25:58,291 DEBUG : BROWSER_OUTPUT: 17:25:58 INFO - 2015-12-18 17:25:58,292 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5266.80 Median:5485.67 stddev:582.67 (10.6%) stddev-sans-first:558.31 17:25:58 INFO - 2015-12-18 17:25:58,292 DEBUG : BROWSER_OUTPUT: Values: 3066.7 3120.2 3145.4 3154.7 3181.1 5106.4 5252.5 5264.9 5267.1 5285.6 5179.6 5247.3 5260.1 5386.2 5423.4 4807.0 4816.3 4851.3 4865.4 4883.4 4882.1 4912.2 4922.7 4966.8 4993.4 4696.8 4719.7 4796.2 4826.1 4831.3 4768.6 4794.0 4833.1 4837.5 4879.9 4747.7 4771.0 4783.3 4798.4 4846.1 4946.9 5039.4 5039.5 5093.1 5170.1 5713.7 5719.7 5729.4 5729.7 5737.4 5742.1 5745.2 5748.9 5749.4 5778.3 5175.2 5282.2 5286.8 5361.2 5403.6 5769.7 5772.8 5791.4 5799.6 5825.8 5484.6 5559.2 5571.9 5573.8 5608.0 5629.5 5667.0 5701.7 5778.1 5837.4 5630.7 5634.2 5660.5 5663.8 5666.4 5485.7 5622.3 5643.5 5660.2 5673.9 4371.9 4398.0 4434.4 4445.7 4476.8 3910.0 3911.3 3914.9 3951.7 3959.7 5243.2 5346.6 5353.5 5353.8 5356.5 5634.1 5673.3 5703.7 5707.2 5744.9 5336.9 5340.4 5341.3 5361.7 5362.3 4808.1 4893.4 4912.7 4925.5 4998.5 5822.2 5852.3 5853.6 5856.4 5859.9 5690.0 5690.2 5710.1 5711.0 5725.3 5607.7 5689.1 5740.2 5826.9 5854.2 5596.2 5608.4 5610.0 5615.8 5616.2 5633.2 5684.4 5691.5 5695.3 5700.4 5533.3 5533.3 5539.3 5540.8 5568.6 5474.3 5560.4 5595.9 5608.9 5612.7 5498.6 5509.5 5511.6 5512.9 5513.7 5615.0 5629.8 5629.8 5638.2 5645.4 5265.5 5308.9 5313.7 5335.2 5339.3 17:25:58 INFO - 2015-12-18 17:25:58,292 DEBUG : BROWSER_OUTPUT: 17:25:58 INFO - 2015-12-18 17:25:58,292 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49413.47 Median:37261.72 stddev:83336.98 (223.7%) stddev-sans-first:83489.99 17:25:58 INFO - 2015-12-18 17:25:58,294 DEBUG : BROWSER_OUTPUT: Values: 545.0 592.7 601.8 602.8 613.7 30474.8 31094.0 31095.7 31157.8 38626.2 43079.8 43689.3 43777.6 43817.0 43874.0 8584.3 8821.5 8837.0 8839.5 8844.8 7741.3 7896.1 7904.2 8602.6 8707.9 10415.3 10680.2 10707.9 10734.5 10769.1 10303.7 10358.0 10428.2 10447.4 10456.4 7681.8 7831.6 7847.0 10233.8 10381.5 43124.4 44243.8 44244.8 44276.3 44304.0 3355.2 3361.5 3390.4 3423.3 3528.0 29759.6 29898.9 30269.2 30847.8 31463.8 3748.3 3774.2 3837.3 3852.7 3876.2 264508.0 268353.0 268381.0 268517.0 269124.7 61994.0 62151.1 62416.4 62427.4 62439.8 65785.7 65817.0 65958.3 66002.0 66036.7 15034.2 15254.9 15407.3 15439.5 15457.5 11104.5 11118.7 11121.8 11127.6 11139.5 19410.0 20377.8 20459.3 20507.7 20596.0 8020.0 8143.5 8172.2 8224.3 8320.9 923.7 950.2 955.2 1026.7 1045.3 28604.6 28637.7 28778.4 29087.0 29124.6 947.0 1009.9 1023.3 1041.3 1058.8 13605.3 13849.5 13852.3 16497.3 17179.3 369866.0 375380.0 375482.0 375492.0 377070.0 54814.2 54874.2 55123.4 55137.2 55506.4 1351.4 1362.9 1370.7 1378.1 1482.0 29470.3 30515.0 31686.0 32931.8 33060.8 50123.0 50523.7 50699.5 50722.0 50784.0 301582.0 301621.0 301912.0 302944.0 303677.0 38673.4 39412.6 45293.3 45377.8 45987.3 40665.0 40703.6 41240.4 42056.0 42315.8 33925.0 35982.0 36494.5 36685.0 37212.0 40598.8 41677.8 41768.2 42046.8 42750.6 32910.8 33446.8 40481.2 40700.8 40949.8 33114.3 37311.4 37541.8 37775.8 38048.2 24365.1 24597.9 24721.0 24903.4 24923.4 17:25:58 INFO - 2015-12-18 17:25:58,294 DEBUG : BROWSER_OUTPUT: 17:25:58 INFO - 2015-12-18 17:25:58,294 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:28969.72 Median:18644.08 stddev:88009.27 (472.0%) stddev-sans-first:88229.94 17:25:58 INFO - 2015-12-18 17:25:58,296 DEBUG : BROWSER_OUTPUT: Values: 360.7 366.2 366.3 368.0 370.9 13522.4 13618.7 16188.8 16271.0 16658.0 13506.2 13979.7 16093.2 16434.8 16524.9 5291.9 5388.7 5405.2 5420.7 5432.3 3740.5 3819.1 5283.3 5324.1 5491.4 5319.7 5508.3 5516.7 5525.7 5535.3 5394.3 5496.8 5503.8 5847.2 5858.8 5248.9 5266.9 5273.4 5274.2 5278.0 12910.2 13297.5 18256.8 20717.7 20760.0 2044.3 2049.8 2087.5 2107.3 2170.9 9135.6 9305.7 9346.2 9581.6 11083.6 1784.0 1809.9 1815.8 1830.7 1852.1 61336.6 66034.3 66102.0 66186.7 66451.0 10211.5 10254.5 10288.5 10344.3 10396.2 13490.4 13568.5 13593.8 13596.9 13601.2 7441.7 7514.4 7525.5 7558.3 7576.8 7140.9 7149.1 7165.4 7190.6 7257.7 4386.1 4441.3 4447.5 4468.7 4469.8 1722.9 1747.1 1767.5 1831.0 1858.3 869.7 927.2 1002.5 1011.9 1063.7 16914.2 17075.8 17429.5 17638.6 17666.9 775.4 889.2 914.8 924.3 942.5 9083.9 9230.0 9360.9 9449.4 9867.3 528990.0 529393.0 538812.0 545566.0 546878.0 79318.0 80647.6 81334.6 83285.6 84395.0 1158.6 1165.7 1223.6 1232.2 1248.3 15676.5 15848.0 16016.8 16040.2 16130.2 36161.8 36770.8 36917.3 37335.0 37470.9 47014.5 47566.3 48936.3 49126.5 50353.2 9087.1 9236.9 9498.4 9581.1 9824.9 16313.8 17313.5 17859.9 17893.9 18026.1 13300.4 13519.5 14671.9 14954.3 14984.1 14399.6 14625.0 14634.3 14997.9 15263.4 15126.4 15148.9 15275.6 15608.7 15746.1 9374.8 9387.4 9489.2 9497.0 9510.7 10567.0 10686.6 13716.6 14131.7 15107.1 17:25:58 INFO - 2015-12-18 17:25:58,296 DEBUG : BROWSER_OUTPUT: 17:25:58 INFO - 2015-12-18 17:25:58,296 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5163.69 Median:6414.62 stddev:2595.11 (40.5%) stddev-sans-first:2585.98 17:25:58 INFO - 2015-12-18 17:25:58,296 DEBUG : BROWSER_OUTPUT: Values: 1281.7 1658.9 1672.7 1697.0 1700.0 6438.2 7114.4 7327.3 7344.1 7344.4 7234.4 7339.0 7397.4 7398.3 7418.6 1956.6 2006.3 2010.4 2157.8 2205.4 1801.0 2136.9 2168.5 2175.9 2180.2 2069.2 2104.4 2113.1 2113.5 2161.8 2179.7 2204.6 2206.6 2209.5 2211.5 2192.8 2233.3 2236.1 2247.5 2248.7 6917.8 6934.8 6992.7 6998.5 7003.1 4514.6 4568.1 4595.3 4607.1 4609.8 2946.5 2998.4 3072.9 3074.0 3076.5 979.7 983.9 988.1 1018.2 1072.0 9943.5 9946.0 9948.9 9956.7 9970.1 4113.3 4114.7 4156.2 4162.2 4173.7 8520.8 8534.5 8545.2 8558.7 8559.3 4575.8 4613.2 4616.0 4619.9 4624.1 4200.2 4227.3 4230.6 4231.1 4234.6 3142.2 3504.4 3512.9 3516.1 3552.7 1034.6 1115.9 1162.1 1163.0 1171.8 1035.2 1037.0 1097.7 1216.4 1336.3 6938.0 6979.7 6991.9 6999.3 7004.3 1093.5 1102.7 1117.6 1134.6 1139.5 5495.3 5577.3 5611.5 5615.9 5619.7 8171.8 8197.2 8198.1 8294.8 8321.1 8083.9 8171.8 8228.0 8248.9 8356.5 6950.7 6990.0 6997.8 7006.9 7066.5 6679.5 6766.3 6804.4 6856.6 6858.0 7815.5 7883.7 7888.3 8022.8 8045.6 8022.0 8055.9 8199.7 8224.1 8274.5 6415.6 6419.9 6474.2 6474.2 6477.0 6221.5 6593.7 7131.6 7202.1 7271.0 6623.2 6675.9 6736.6 6808.9 6883.8 6645.1 6674.1 6687.9 6695.2 6702.5 6746.0 6767.3 6771.5 6783.0 6814.8 6329.2 6403.9 6413.6 6415.7 6420.5 6285.7 6388.5 6388.8 6389.3 6405.2 17:25:58 INFO - 2015-12-18 17:25:58,296 DEBUG : BROWSER_OUTPUT: 17:25:58 INFO - 2015-12-18 17:25:58,296 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5299.40 Median:6008.24 stddev:1593.25 (26.5%) stddev-sans-first:1553.37 17:25:58 INFO - 2015-12-18 17:25:58,298 DEBUG : BROWSER_OUTPUT: Values: 325.8 329.8 340.7 341.5 345.1 5919.1 5922.6 5956.0 5964.7 6033.8 5637.6 5685.1 5810.5 5820.9 5903.4 4571.6 4594.8 4600.9 4611.2 4617.9 4400.7 4619.5 4624.5 4625.8 4634.1 4383.9 4464.9 4505.5 4520.0 4524.5 4496.0 4522.5 4523.2 4529.0 4530.5 3954.1 3971.2 3973.3 3973.3 3980.1 5548.9 5567.0 5609.4 5644.8 5665.6 5310.7 5316.9 5320.5 5324.1 5329.5 6222.2 6256.3 6258.9 6264.5 6285.9 4469.2 4475.9 4479.9 4482.1 4498.5 6388.3 6535.8 6550.5 6552.8 6557.6 4539.6 4549.6 4549.7 4552.5 4560.1 4585.4 4592.2 4592.5 4594.7 4595.8 5279.8 5288.6 5298.8 5306.5 5309.8 6145.6 6347.1 6359.3 6367.3 6371.5 1562.6 1579.0 1579.2 1581.7 1586.9 1046.4 1074.7 1079.6 1083.0 1105.1 6062.5 6084.1 6087.9 6093.2 6111.0 6542.1 6548.6 6549.4 6550.8 6558.8 5902.1 5982.7 6066.8 6089.4 6099.9 3523.3 3540.8 3557.6 3561.0 3561.1 6434.0 6584.2 6704.5 6705.8 6708.6 6537.4 6721.4 6726.8 6728.6 6755.1 6699.6 6707.3 6719.1 6720.8 6720.9 6461.5 6598.6 6601.3 6601.8 6613.6 6469.6 6483.7 6484.0 6493.7 6514.6 6713.4 6714.4 6714.4 6718.3 6719.7 4433.1 4530.1 4537.0 4537.3 4552.9 6553.1 6578.5 6579.0 6586.1 6591.4 6416.7 6417.7 6421.4 6434.0 6447.4 6222.6 6364.5 6406.6 6411.0 6435.1 6239.8 6250.7 6296.6 6336.3 6338.6 6465.7 6472.4 6473.9 6476.7 6479.5 6124.9 6305.1 6313.1 6321.6 6322.0 17:25:58 INFO - 2015-12-18 17:25:58,298 DEBUG : BROWSER_OUTPUT: 17:25:58 INFO - 2015-12-18 17:25:58,298 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13398.34 Median:44766.16 stddev:15045.27 (33.6%) stddev-sans-first:15057.47 17:25:58 INFO - 2015-12-18 17:25:58,299 DEBUG : BROWSER_OUTPUT: Values: 744.2 746.1 752.7 767.4 844.7 13974.3 14202.7 14227.4 14249.7 14252.1 13217.3 13242.1 13273.2 13289.5 13349.7 680.8 686.1 801.8 818.5 819.6 823.5 827.5 833.5 833.9 836.2 711.0 857.4 866.3 867.8 868.6 696.6 703.2 705.4 840.8 856.2 629.2 631.1 634.0 634.2 637.0 12347.4 12373.4 12394.4 12396.1 12437.2 12007.3 12017.4 12175.3 12234.5 12281.7 9432.6 9628.8 10003.4 10016.4 10166.3 3481.3 3576.9 3582.7 3644.9 3676.9 44269.1 44372.6 44534.3 44663.8 44730.3 9275.7 9647.9 9801.0 9885.5 10418.7 18148.1 18286.0 18311.5 18502.6 18546.4 7397.7 7452.3 7629.1 7677.9 7830.6 4197.9 4259.3 4274.2 4277.8 4365.6 3057.7 3084.7 3090.2 3091.0 3097.8 570.2 576.5 578.3 591.1 604.7 661.6 691.2 693.0 693.3 709.0 8991.8 9065.9 9082.8 9389.0 9517.5 622.0 630.2 681.5 684.8 703.2 3593.3 3634.9 4044.5 4153.5 4159.6 50776.0 51296.0 51814.7 52029.0 52421.5 47903.5 48327.3 48830.5 48846.8 49272.8 44571.8 44651.8 44802.0 45075.5 46117.4 7618.3 7738.2 7754.3 7773.9 7779.1 33614.0 35014.5 35877.8 36788.4 37451.8 42754.4 43502.3 43895.3 44081.0 44270.6 10733.3 11026.4 11040.2 11196.0 11276.8 11882.5 12325.6 12356.3 12382.4 13470.9 11296.2 11433.5 11589.8 11774.4 12302.5 11282.5 11576.4 11645.8 11716.0 11944.5 10877.9 11009.4 11550.2 11656.7 11970.0 9116.4 9423.3 9494.5 9581.8 9618.0 9061.0 9085.0 9574.4 9578.3 9592.3 17:25:58 INFO - 2015-12-18 17:25:58,299 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:25:58 INFO - 2015-12-18 17:25:58,299 DEBUG : BROWSER_OUTPUT: 17:25:58 INFO - 2015-12-18 17:25:58,996 INFO : Browser exited with error code: 0 17:25:59 INFO - 2015-12-18 17:25:59,012 INFO : Completed test dromaeo_css (00:18:33) 17:25:59 INFO - 2015-12-18 17:25:59,013 INFO : Starting test kraken 17:25:59 INFO - 2015-12-18 17:25:59,013 DEBUG : operating with platform_type : linux_ 17:25:59 INFO - 2015-12-18 17:25:59,013 INFO : Initialising browser for kraken test... 17:25:59 INFO - 2015-12-18 17:25:59,019 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpixPH3W/profile http://localhost:49450/getInfo.html 17:26:03 INFO - 2015-12-18 17:26:03,167 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:26:03 INFO - 2015-12-18 17:26:03,167 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:26:03 INFO - 2015-12-18 17:26:03,167 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:26:03 INFO - 2015-12-18 17:26:03,167 DEBUG : BROWSER_OUTPUT: __metrics 17:26:03 INFO - 2015-12-18 17:26:03,268 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:26:03 INFO - 2015-12-18 17:26:03,325 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:26:03 ERROR - 2015-12-18 17:26:03,345 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 17:26:03 INFO - 2015-12-18 17:26:03,609 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 17:26:04 INFO - 2015-12-18 17:26:04,237 INFO : Browser initialized. 17:26:04 INFO - 2015-12-18 17:26:04,238 INFO : Running cycle 1/1 for kraken test... 17:26:04 INFO - 2015-12-18 17:26:04,238 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpixPH3W/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:26:16 INFO - 2015-12-18 17:26:16,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 147079168 17:26:16 INFO - 2015-12-18 17:26:16,063 DEBUG : BROWSER_OUTPUT: 17:26:18 INFO - 2015-12-18 17:26:18,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49450/tests/kraken/driver.html?testName=audio-beat-detection) 17:26:19 INFO - 2015-12-18 17:26:19,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 184045568 17:26:19 INFO - 2015-12-18 17:26:19,135 DEBUG : BROWSER_OUTPUT: 17:26:21 INFO - 2015-12-18 17:26:21,758 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49450/tests/kraken/driver.html?testName=audio-dft) 17:26:22 INFO - 2015-12-18 17:26:22,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 173928448 17:26:22 INFO - 2015-12-18 17:26:22,331 DEBUG : BROWSER_OUTPUT: 17:26:25 INFO - 2015-12-18 17:26:25,192 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49450/tests/kraken/driver.html?testName=audio-fft) 17:26:25 INFO - 2015-12-18 17:26:25,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 158801920 17:26:25 INFO - 2015-12-18 17:26:25,754 DEBUG : BROWSER_OUTPUT: 17:26:27 INFO - 2015-12-18 17:26:27,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49450/tests/kraken/driver.html?testName=audio-oscillator) 17:26:28 INFO - 2015-12-18 17:26:28,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 160833536 17:26:28 INFO - 2015-12-18 17:26:28,288 DEBUG : BROWSER_OUTPUT: 17:26:30 INFO - 2015-12-18 17:26:30,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49450/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:26:31 INFO - 2015-12-18 17:26:31,048 DEBUG : BROWSER_OUTPUT: RSS: Main: 161538048 17:26:31 INFO - 2015-12-18 17:26:31,048 DEBUG : BROWSER_OUTPUT: 17:26:33 INFO - 2015-12-18 17:26:33,932 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49450/tests/kraken/driver.html?testName=imaging-darkroom) 17:26:34 INFO - 2015-12-18 17:26:34,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 161701888 17:26:34 INFO - 2015-12-18 17:26:34,501 DEBUG : BROWSER_OUTPUT: 17:26:37 INFO - 2015-12-18 17:26:37,856 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49450/tests/kraken/driver.html?testName=imaging-desaturate) 17:26:38 INFO - 2015-12-18 17:26:38,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 162086912 17:26:38 INFO - 2015-12-18 17:26:38,429 DEBUG : BROWSER_OUTPUT: 17:26:41 INFO - 2015-12-18 17:26:41,152 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49450/tests/kraken/driver.html?testName=json-parse-financial) 17:26:41 INFO - 2015-12-18 17:26:41,726 DEBUG : BROWSER_OUTPUT: RSS: Main: 162799616 17:26:41 INFO - 2015-12-18 17:26:41,726 DEBUG : BROWSER_OUTPUT: 17:26:43 INFO - 2015-12-18 17:26:43,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49450/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:26:43 INFO - 2015-12-18 17:26:43,868 DEBUG : BROWSER_OUTPUT: RSS: Main: 172441600 17:26:43 INFO - 2015-12-18 17:26:43,868 DEBUG : BROWSER_OUTPUT: 17:26:45 INFO - 2015-12-18 17:26:45,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:26:46 INFO - 2015-12-18 17:26:46,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 170397696 17:26:46 INFO - 2015-12-18 17:26:46,286 DEBUG : BROWSER_OUTPUT: 17:26:48 INFO - 2015-12-18 17:26:48,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:26:48 INFO - 2015-12-18 17:26:48,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 186167296 17:26:48 INFO - 2015-12-18 17:26:48,903 DEBUG : BROWSER_OUTPUT: 17:26:51 INFO - 2015-12-18 17:26:51,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:26:51 INFO - 2015-12-18 17:26:51,903 DEBUG : BROWSER_OUTPUT: RSS: Main: 190046208 17:26:51 INFO - 2015-12-18 17:26:51,903 DEBUG : BROWSER_OUTPUT: 17:26:54 INFO - 2015-12-18 17:26:54,520 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:26:55 INFO - 2015-12-18 17:26:55,089 DEBUG : BROWSER_OUTPUT: RSS: Main: 186941440 17:26:55 INFO - 2015-12-18 17:26:55,089 DEBUG : BROWSER_OUTPUT: 17:26:56 INFO - 2015-12-18 17:26:56,758 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49450/tests/kraken/driver.html?testName=ai-astar) 17:26:57 INFO - 2015-12-18 17:26:57,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 246169600 17:26:57 INFO - 2015-12-18 17:26:57,016 DEBUG : BROWSER_OUTPUT: 17:26:57 INFO - 2015-12-18 17:26:57,017 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:26:57 INFO - 2015-12-18 17:26:57,017 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:26:57 INFO - 2015-12-18 17:26:57,017 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:26:57 INFO - 2015-12-18 17:26:57,017 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:26:57 INFO - 2015-12-18 17:26:57,017 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;105;111;110;111;101;110;110;119 17:26:57 INFO - 2015-12-18 17:26:57,017 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;123;150;166;130;145;144;133;168;123 17:26:57 INFO - 2015-12-18 17:26:57,017 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;166;162;161;160;160;163;161;164;161 17:26:57 INFO - 2015-12-18 17:26:57,018 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;83;93;70;70;71;106;89;72 17:26:57 INFO - 2015-12-18 17:26:57,018 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;138;94;94;94;141;94;94;133 17:26:57 INFO - 2015-12-18 17:26:57,018 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;110;110;110;110;110;111;110;110;110 17:26:57 INFO - 2015-12-18 17:26:57,018 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;146;147;147;147;146;148;146 17:26:57 INFO - 2015-12-18 17:26:57,018 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;95;95;96;96;95;96;96 17:26:57 INFO - 2015-12-18 17:26:57,018 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;59;60;60;59;59;60;68;56;57 17:26:57 INFO - 2015-12-18 17:26:57,019 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;68;67;67;67;68;68;68;68;67 17:26:57 INFO - 2015-12-18 17:26:57,019 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;85;86;86;86;86;85;85;86;86 17:26:57 INFO - 2015-12-18 17:26:57,019 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;115;117;121;121;121;122;125;120;126 17:26:57 INFO - 2015-12-18 17:26:57,019 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;144;155;153;154;163;147;154;162;143;144 17:26:57 INFO - 2015-12-18 17:26:57,019 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;69;69;67;67;68;66;67;67;69 17:26:57 INFO - 2015-12-18 17:26:57,019 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:26:57 INFO - 2015-12-18 17:26:57,020 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:26:57 INFO - 2015-12-18 17:26:57,020 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,914 17:26:57 INFO - 2015-12-18 17:26:57,020 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:26:57 INFO - 2015-12-18 17:26:57,020 DEBUG : BROWSER_OUTPUT: __startTimestamp1450488417011__endTimestamp 17:26:57 INFO - 2015-12-18 17:26:57,020 DEBUG : BROWSER_OUTPUT: 17:26:57 INFO - 2015-12-18 17:26:57,020 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:26:57 INFO - 2015-12-18 17:26:57,020 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:26:57 INFO - 2015-12-18 17:26:57,020 DEBUG : BROWSER_OUTPUT: 17:26:57 INFO - 2015-12-18 17:26:57,020 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:4.64 (4.2%) stddev-sans-first:4.91 17:26:57 INFO - 2015-12-18 17:26:57,020 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 105.0 111.0 110.0 111.0 101.0 110.0 110.0 119.0 17:26:57 INFO - 2015-12-18 17:26:57,021 DEBUG : BROWSER_OUTPUT: 17:26:57 INFO - 2015-12-18 17:26:57,021 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.00 Median:147.50 stddev:16.64 (11.3%) stddev-sans-first:16.86 17:26:57 INFO - 2015-12-18 17:26:57,021 DEBUG : BROWSER_OUTPUT: Values: 158.0 123.0 150.0 166.0 130.0 145.0 144.0 133.0 168.0 123.0 17:26:57 INFO - 2015-12-18 17:26:57,021 DEBUG : BROWSER_OUTPUT: 17:26:57 INFO - 2015-12-18 17:26:57,021 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.91 (1.2%) stddev-sans-first:2.00 17:26:57 INFO - 2015-12-18 17:26:57,021 DEBUG : BROWSER_OUTPUT: Values: 163.0 166.0 162.0 161.0 160.0 160.0 163.0 161.0 164.0 161.0 17:26:57 INFO - 2015-12-18 17:26:57,021 DEBUG : BROWSER_OUTPUT: 17:26:57 INFO - 2015-12-18 17:26:57,021 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.80 Median:72.00 stddev:12.51 (17.4%) stddev-sans-first:12.94 17:26:57 INFO - 2015-12-18 17:26:57,021 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 83.0 93.0 70.0 70.0 71.0 106.0 89.0 72.0 17:26:57 INFO - 2015-12-18 17:26:57,021 DEBUG : BROWSER_OUTPUT: 17:26:57 INFO - 2015-12-18 17:26:57,021 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.10 Median:94.00 stddev:20.95 (22.3%) stddev-sans-first:21.68 17:26:57 INFO - 2015-12-18 17:26:57,022 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 138.0 94.0 94.0 94.0 141.0 94.0 94.0 133.0 17:26:57 INFO - 2015-12-18 17:26:57,022 DEBUG : BROWSER_OUTPUT: 17:26:57 INFO - 2015-12-18 17:26:57,022 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 17:26:57 INFO - 2015-12-18 17:26:57,022 DEBUG : BROWSER_OUTPUT: Values: 111.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 110.0 17:26:57 INFO - 2015-12-18 17:26:57,022 DEBUG : BROWSER_OUTPUT: 17:26:57 INFO - 2015-12-18 17:26:57,022 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 17:26:57 INFO - 2015-12-18 17:26:57,022 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 148.0 146.0 17:26:57 INFO - 2015-12-18 17:26:57,022 DEBUG : BROWSER_OUTPUT: 17:26:57 INFO - 2015-12-18 17:26:57,022 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 17:26:57 INFO - 2015-12-18 17:26:57,022 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 95.0 95.0 96.0 96.0 95.0 96.0 96.0 17:26:57 INFO - 2015-12-18 17:26:57,022 DEBUG : BROWSER_OUTPUT: 17:26:57 INFO - 2015-12-18 17:26:57,022 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.60 Median:59.50 stddev:3.24 (5.4%) stddev-sans-first:3.38 17:26:57 INFO - 2015-12-18 17:26:57,023 DEBUG : BROWSER_OUTPUT: Values: 58.0 59.0 60.0 60.0 59.0 59.0 60.0 68.0 56.0 57.0 17:26:57 INFO - 2015-12-18 17:26:57,023 DEBUG : BROWSER_OUTPUT: 17:26:57 INFO - 2015-12-18 17:26:57,024 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.53 17:26:57 INFO - 2015-12-18 17:26:57,024 DEBUG : BROWSER_OUTPUT: Values: 69.0 68.0 67.0 67.0 67.0 68.0 68.0 68.0 68.0 67.0 17:26:57 INFO - 2015-12-18 17:26:57,024 DEBUG : BROWSER_OUTPUT: 17:26:57 INFO - 2015-12-18 17:26:57,024 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.00 stddev:0.71 (0.8%) stddev-sans-first:0.50 17:26:57 INFO - 2015-12-18 17:26:57,024 DEBUG : BROWSER_OUTPUT: Values: 84.0 85.0 86.0 86.0 86.0 86.0 85.0 85.0 86.0 86.0 17:26:57 INFO - 2015-12-18 17:26:57,024 DEBUG : BROWSER_OUTPUT: 17:26:57 INFO - 2015-12-18 17:26:57,024 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:121.00 stddev:3.60 (3.0%) stddev-sans-first:3.44 17:26:57 INFO - 2015-12-18 17:26:57,024 DEBUG : BROWSER_OUTPUT: Values: 116.0 115.0 117.0 121.0 121.0 121.0 122.0 125.0 120.0 126.0 17:26:57 INFO - 2015-12-18 17:26:57,024 DEBUG : BROWSER_OUTPUT: 17:26:57 INFO - 2015-12-18 17:26:57,024 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.90 Median:154.00 stddev:7.25 (4.7%) stddev-sans-first:7.10 17:26:57 INFO - 2015-12-18 17:26:57,024 DEBUG : BROWSER_OUTPUT: Values: 144.0 155.0 153.0 154.0 163.0 147.0 154.0 162.0 143.0 144.0 17:26:57 INFO - 2015-12-18 17:26:57,024 DEBUG : BROWSER_OUTPUT: 17:26:57 INFO - 2015-12-18 17:26:57,024 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.07 (1.6%) stddev-sans-first:1.12 17:26:57 INFO - 2015-12-18 17:26:57,025 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 69.0 67.0 67.0 68.0 66.0 67.0 67.0 69.0 17:26:57 INFO - 2015-12-18 17:26:57,025 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:26:57 INFO - 2015-12-18 17:26:57,025 DEBUG : BROWSER_OUTPUT: 17:26:57 INFO - 2015-12-18 17:26:57,852 INFO : Browser exited with error code: 0 17:26:57 INFO - 2015-12-18 17:26:57,903 INFO : Completed test kraken (00:00:58) 17:26:57 INFO - 2015-12-18 17:26:57,903 INFO : Starting test v8_7 17:26:57 INFO - 2015-12-18 17:26:57,903 DEBUG : operating with platform_type : linux_ 17:26:57 INFO - 2015-12-18 17:26:57,903 INFO : Initialising browser for v8_7 test... 17:26:57 INFO - 2015-12-18 17:26:57,909 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdEUhJ6/profile http://localhost:49450/getInfo.html 17:27:01 INFO - 2015-12-18 17:27:01,892 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:27:01 INFO - 2015-12-18 17:27:01,892 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:27:01 INFO - 2015-12-18 17:27:01,892 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:27:01 INFO - 2015-12-18 17:27:01,892 DEBUG : BROWSER_OUTPUT: __metrics 17:27:02 INFO - 2015-12-18 17:27:02,054 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:27:02 INFO - 2015-12-18 17:27:02,101 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:27:03 INFO - 2015-12-18 17:27:03,179 INFO : Browser initialized. 17:27:03 INFO - 2015-12-18 17:27:03,179 INFO : Running cycle 1/1 for v8_7 test... 17:27:03 INFO - 2015-12-18 17:27:03,179 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdEUhJ6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:27:14 INFO - 2015-12-18 17:27:14,983 DEBUG : BROWSER_OUTPUT: RSS: Main: 149835776 17:27:14 INFO - 2015-12-18 17:27:14,983 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-18 17:27:36,350 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49450/tests/v8_7/run.html (next: http://localhost:49450/tests/v8_7/run.html) 17:27:36 INFO - 2015-12-18 17:27:36,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 551202816 17:27:36 INFO - 2015-12-18 17:27:36,600 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-18 17:27:36,601 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:27:36 INFO - 2015-12-18 17:27:36,602 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:27:36 INFO - 2015-12-18 17:27:36,602 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:27:36 INFO - 2015-12-18 17:27:36,602 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:27:36 INFO - 2015-12-18 17:27:36,602 DEBUG : BROWSER_OUTPUT: |0;Richards;166.61112962345885 17:27:36 INFO - 2015-12-18 17:27:36,602 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;189.53752843062927 17:27:36 INFO - 2015-12-18 17:27:36,602 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.58361391694723 17:27:36 INFO - 2015-12-18 17:27:36,602 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5159.79381443299 17:27:36 INFO - 2015-12-18 17:27:36,603 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1928.7090558766859 17:27:36 INFO - 2015-12-18 17:27:36,603 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 17:27:36 INFO - 2015-12-18 17:27:36,603 DEBUG : BROWSER_OUTPUT: |6;Boyer;12493.827160493827 17:27:36 INFO - 2015-12-18 17:27:36,603 DEBUG : BROWSER_OUTPUT: |7;RegExp;26342.105263157893 17:27:36 INFO - 2015-12-18 17:27:36,603 DEBUG : BROWSER_OUTPUT: |8;Splay;577.0340450086555 17:27:36 INFO - 2015-12-18 17:27:36,603 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 17:27:36 INFO - 2015-12-18 17:27:36,604 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:27:36 INFO - 2015-12-18 17:27:36,604 DEBUG : BROWSER_OUTPUT: __startTimestamp1450488456600__endTimestamp 17:27:36 INFO - 2015-12-18 17:27:36,604 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-18 17:27:36,604 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:27:36 INFO - 2015-12-18 17:27:36,604 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:27:36 INFO - 2015-12-18 17:27:36,604 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-18 17:27:36,605 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.61 Median:166.61 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-18 17:27:36,605 DEBUG : BROWSER_OUTPUT: Values: 166.6 17:27:36 INFO - 2015-12-18 17:27:36,605 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-18 17:27:36,605 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:189.54 Median:189.54 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-18 17:27:36,606 DEBUG : BROWSER_OUTPUT: Values: 189.5 17:27:36 INFO - 2015-12-18 17:27:36,607 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-18 17:27:36,607 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.58 Median:280.58 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-18 17:27:36,607 DEBUG : BROWSER_OUTPUT: Values: 280.6 17:27:36 INFO - 2015-12-18 17:27:36,607 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-18 17:27:36,607 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-18 17:27:36,607 DEBUG : BROWSER_OUTPUT: Values: 5159.8 17:27:36 INFO - 2015-12-18 17:27:36,607 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-18 17:27:36,608 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1928.71 Median:1928.71 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-18 17:27:36,608 DEBUG : BROWSER_OUTPUT: Values: 1928.7 17:27:36 INFO - 2015-12-18 17:27:36,608 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-18 17:27:36,608 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-18 17:27:36,608 DEBUG : BROWSER_OUTPUT: Values: 794.3 17:27:36 INFO - 2015-12-18 17:27:36,608 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-18 17:27:36,608 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12493.83 Median:12493.83 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-18 17:27:36,609 DEBUG : BROWSER_OUTPUT: Values: 12493.8 17:27:36 INFO - 2015-12-18 17:27:36,609 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-18 17:27:36,609 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26342.11 Median:26342.11 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-18 17:27:36,609 DEBUG : BROWSER_OUTPUT: Values: 26342.1 17:27:36 INFO - 2015-12-18 17:27:36,609 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-18 17:27:36,609 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:577.03 Median:577.03 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-18 17:27:36,609 DEBUG : BROWSER_OUTPUT: Values: 577.0 17:27:36 INFO - 2015-12-18 17:27:36,609 DEBUG : BROWSER_OUTPUT: 17:27:36 INFO - 2015-12-18 17:27:36,610 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 17:27:36 INFO - 2015-12-18 17:27:36,610 DEBUG : BROWSER_OUTPUT: Values: 4850.2 17:27:36 INFO - 2015-12-18 17:27:36,610 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:27:36 INFO - 2015-12-18 17:27:36,610 DEBUG : BROWSER_OUTPUT: 17:27:37 INFO - 2015-12-18 17:27:37,392 INFO : Browser exited with error code: 0 17:27:37 INFO - 2015-12-18 17:27:37,407 INFO : Completed test v8_7 (00:00:39) 17:27:37 INFO - 2015-12-18 17:27:37,649 INFO : Completed test suite (00:20:11) 17:27:37 INFO - 2015-12-18 17:27:37,649 DEBUG : Working with test: dromaeo_css 17:27:37 INFO - 2015-12-18 17:27:37,649 DEBUG : Generating results file: dromaeo_css 17:27:37 INFO - 2015-12-18 17:27:37,650 DEBUG : Working with test: kraken 17:27:37 INFO - 2015-12-18 17:27:37,650 DEBUG : Generating results file: kraken 17:27:37 INFO - 2015-12-18 17:27:37,650 INFO : javascript benchmark 17:27:37 INFO - 2015-12-18 17:27:37,651 DEBUG : Working with test: v8_7 17:27:37 INFO - 2015-12-18 17:27:37,651 DEBUG : Generating results file: v8_7 17:27:37 INFO - 2015-12-18 17:27:37,651 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:27:37 INFO - 2015-12-18 17:27:37,701 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 17:27:37 INFO - 2015-12-18 17:27:37,701 DEBUG : process_Request line: dromaeo_css 6960.40 graph.html#tests=[[72,64,35]] 17:27:37 INFO - 2015-12-18 17:27:37,701 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:27:37 INFO - 2015-12-18 17:27:37,735 DEBUG : process_Request line: kraken 1508.50 graph.html#tests=[[232,64,35]] 17:27:37 INFO - 2015-12-18 17:27:37,735 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:27:37 INFO - 2015-12-18 17:27:37,766 DEBUG : process_Request line: v8_7 19881.67 graph.html#tests=[[230,64,35]] 17:27:37 INFO - 2015-12-18 17:27:37,767 INFO : javascript benchmark 17:27:37 INFO - 2015-12-18 17:27:37,771 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3066.677998810125, 3120.2199450137464, 3145.3866496033256, 3154.747620190385, 3181.0933883843104, 5106.361704786902, 5252.47475252475, 5264.868378290545, 5267.130923397634, 5285.6300058995885, 5179.637425380225, 5247.291615631889, 5260.132078207101, 5386.165144402614, 5423.403425623178, 4807.0, 4816.277558366256, 4851.27230915362, 4865.391826021747, 4883.438404583465, 4882.096812089757, 4912.21404575268, 4922.655414121013, 4966.751662416883, 4993.350864387625, 4696.835610753607, 4719.740414277213, 4796.184648609745, 4826.058918510892, 4831.347768051303, 4768.642351823592, 4794.041191761627, 4833.057553777015, 4837.540433658797, 4879.8780030499165, 4747.667663263573, 4770.952290477086, 4783.28250762385, 4798.4001999750035, 4846.0550192712435, 4946.851594452136, 5039.395272567315, 5039.496050394968, 5093.083245015896, 5170.146925757245, 5713.714314284311, 5719.7140142992685, 5729.427057294237, 5729.684867332295, 5737.3975732548315, 5742.08126699726, 5745.2243947067445, 5748.913766293509, 5749.367569567345, 5778.335491418498, 5175.171972484384, 5282.181261904411, 5286.762095705664, 5361.249425080492, 5403.621746477748, 5769.653820770767, 5772.826815195467, 5791.362950075489, 5799.623024503394, 5825.79609713658, 5484.588655850827, 5559.166125081189, 5571.860703482364, 5573.804916827891, 5608.0, 5629.4652008059165, 5667.036603777367, 5701.71491425427, 5778.133280008033, 5837.445442682938, 5630.690312032795, 5634.1830434586755, 5660.490555849911, 5663.80176693822, 5666.4050274721385, 5485.670859748428, 5622.325320961429, 5643.463870932255, 5660.235868157828, 5673.914891276634, 4371.912561748811, 4397.978010109929, 4434.357018232338, 4445.666575006888, 4476.843310484118, 3909.980450097731, 3911.3155197840265, 3914.921701565953, 3951.703622228287, 3959.7228194026716, 5243.23973023917, 5346.572274218053, 5353.491418315254, 5353.785848566092, 5356.517913387814, 5634.126710359901, 5673.262475878192, 5703.686297253691, 5707.229524014288, 5744.856378590569, 5336.893262134736, 5340.385855626652, 5341.305630268041, 5361.731913404315, 5362.27609272751, 4808.134535783523, 4893.363862697826, 4912.680675756064, 4925.5074492551175, 4998.525140111684, 5822.214001109796, 5852.326982397079, 5853.619514731528, 5856.443637854397, 5859.941400586024, 5690.0, 5690.231818704422, 5710.114932185518, 5710.971445142914, 5725.255716756795, 5607.663540187602, 5689.061304884648, 5740.196372507936, 5826.912596310974, 5854.209681693087, 5596.244506991504, 5608.4111168326735, 5610.018246806874, 5615.831525054255, 5616.185653080199, 5633.2395126657375, 5684.403137670485, 5691.544676425793, 5695.288088988877, 5700.372958974593, 5533.253010843646, 5533.280673512418, 5539.307586551681, 5540.833774986757, 5568.582356323211, 5474.260974768515, 5560.388357280615, 5595.8880822384135, 5608.859778505407, 5612.663240205601, 5498.5876059294915, 5509.5041446270025, 5511.586631002771, 5512.944870551243, 5513.669179849222, 5614.9719251403485, 5629.7748090077575, 5629.802956896489, 5638.182463542681, 5645.350784659652, 5265.52610265078, 5308.893822123613, 5313.681179129265, 5335.226392173191, 5339.25250464943], "unit": "score", "name": "dojo.html", "value": 5228.888061177184}, {"lowerIsBetter": false, "replicates": [544.9996284093442, 592.7184587321022, 601.8344955137339, 602.82819396472, 613.742228264129, 30474.847625761897, 31094.0, 31095.689043109563, 31157.844210778916, 38626.227475450476, 43079.78460107703, 43689.34465983005, 43777.56222437775, 43817.0, 43874.0, 8584.313254939621, 8821.51481668508, 8836.955815220916, 8839.51382673956, 8844.823103537925, 7741.264579864932, 7896.091949425803, 7904.170062143478, 8602.569871506432, 8707.912920870773, 10415.323004004753, 10680.198985076111, 10707.892921070768, 10734.463276836166, 10769.138468922467, 10303.742406439862, 10358.0, 10428.165746740242, 10447.42539160346, 10456.372617642928, 7681.846363072763, 7831.608419579055, 7847.0, 10233.795324093551, 10381.480925953672, 43124.35313470301, 44243.77878110621, 44244.778776106235, 44276.3358549622, 44304.0, 3355.2115252915546, 3361.46216605342, 3390.440577304742, 3423.3153369325987, 3527.9647203528148, 29759.553606695918, 29898.85050574755, 30269.24326891823, 30847.845760771277, 31463.84268078645, 3748.250349929998, 3774.2262836118803, 3837.3092843288196, 3852.672522835562, 3876.2247550490015, 264508.0, 268353.0, 268381.0, 268517.0, 269124.6543767288, 61994.0, 62151.067733984026, 62416.37583624196, 62427.375726243066, 62439.75120497565, 65785.67107164433, 65817.0, 65958.34041659618, 66002.0, 66036.66981665157, 15034.248287585577, 15254.923725381303, 15407.306671199824, 15439.536813895602, 15457.458988935557, 11104.500297486633, 11118.722031949104, 11121.833172502418, 11127.554897803997, 11139.498722557504, 19410.0, 20377.79622203759, 20459.28392506285, 20507.69238461424, 20596.0, 8020.0, 8143.470674406263, 8172.223638754309, 8224.259816616533, 8320.875186872201, 923.6859467780987, 950.1875896108866, 955.159459675495, 1026.6542885653164, 1045.3414348960107, 28604.570931436047, 28637.711302991414, 28778.424431511252, 29087.0, 29124.563131553045, 946.9810603787886, 1009.8939611340703, 1023.3297190340339, 1041.2555023158477, 1058.7760269977937, 13605.31973401326, 13849.515266965607, 13852.307384630729, 16497.340106395848, 17179.31282748701, 369866.0, 375380.0, 375482.0, 375492.0, 377070.0, 54814.177787333225, 54874.17688734672, 55123.44876551183, 55137.172942405894, 55506.44493555013, 1351.439152751597, 1362.9182249065088, 1370.6847425092085, 1378.1248906944163, 1482.0070552729696, 29470.263243418227, 30515.0, 31686.0, 32931.83534082314, 33060.83469582733, 50123.0, 50523.74738126286, 50699.493005069475, 50722.0, 50784.0, 301582.0, 301621.0, 301912.0, 302944.0, 303677.0, 38673.41989870098, 39412.60587394204, 45293.32060019037, 45377.77311113424, 45987.31019034784, 40665.0, 40703.59296406998, 41240.38139427971, 42056.0, 42315.788421057696, 33925.0, 35982.0, 36494.4525832118, 36685.0, 37212.0, 40598.797006015964, 41677.79161104175, 41768.164636707705, 42046.78976605098, 42750.572494275904, 32910.83544582358, 33446.832765836014, 40481.19037619172, 40700.796496017334, 40949.795251023555, 33114.33771324608, 37311.44032839564, 37541.81229093837, 37775.81112094422, 38048.239035219696, 24365.147219847222, 24597.87701061555, 24721.0, 24903.37741556403, 24923.376915577257], "unit": "score", "name": "ext.html", "value": 19252.730628397865}, {"lowerIsBetter": false, "replicates": [360.69701450781355, 366.19071851208827, 366.25649930640793, 367.98528058877645, 370.89800304916145, 13522.391492382842, 13618.659533511667, 16188.757168642465, 16271.0, 16658.0, 13506.18962862229, 13979.720405591883, 16093.195340233, 16434.75347869783, 16524.917375413104, 5291.920621190685, 5388.676679399248, 5405.189221616769, 5420.7018613976215, 5432.320959880015, 3740.4576336431337, 3819.083419979213, 5283.339582552181, 5324.068288049595, 5491.423400542945, 5319.680819150844, 5508.338999320087, 5516.724163791814, 5525.668459892399, 5535.308086489189, 5394.32570928632, 5496.7526461309135, 5503.834884953438, 5847.152162936351, 5858.76564937402, 5248.895022099537, 5266.947330526722, 5273.393559740641, 5274.208868669692, 5278.049951008817, 12910.160839545399, 13297.468101275937, 18256.817431825646, 20717.685170372817, 20760.0, 2044.2640649366217, 2049.7847725988854, 2087.4676957375773, 2107.346722516025, 2170.9240176593903, 9135.634574617008, 9305.674301399418, 9346.15884570392, 9581.616735330648, 11083.556657733681, 1783.9514174885044, 1809.94570162894, 1815.8456531194731, 1830.7162389829464, 1852.129499135404, 61336.5880389571, 66034.33965660378, 66102.0, 66186.66906665484, 66451.0, 10211.540480678239, 10254.53854576546, 10288.537015834305, 10344.275900687031, 10396.16830653546, 13490.39293231807, 13568.457261709618, 13593.824988001872, 13596.912247020215, 13601.183928964294, 7441.702331906663, 7514.39884809214, 7525.548467091992, 7558.26159983196, 7576.848463030708, 7140.892886606705, 7149.0706208192605, 7165.426765858719, 7190.604516751524, 7257.673404696801, 4386.1447017831215, 4441.333799930037, 4447.488538818013, 4468.687191896601, 4469.821207151743, 1722.922468488921, 1747.074050753103, 1767.5492749349091, 1830.9908450457663, 1858.2845604442116, 869.7043005378201, 927.1840780113457, 1002.5037606384886, 1011.8836333821705, 1063.6968463987725, 16914.238859251363, 17075.829241707674, 17429.47711568655, 17638.559036023944, 17666.911665441592, 775.4378075895044, 889.2441424788877, 914.7530166854912, 924.2698268368049, 942.5240253671852, 9083.863742043875, 9229.953850230706, 9360.859587106199, 9449.43303401798, 9867.259955503367, 528990.0, 529393.0, 538812.0, 545566.0, 546878.0, 79318.0, 80647.59676201582, 81334.59332703298, 83285.58357208296, 84395.0, 1158.5771193514306, 1165.6561314412268, 1223.6023292429995, 1232.2336354883344, 1248.2697621891114, 15676.52970410844, 15848.049117053013, 16016.839831602001, 16040.197990100682, 16130.193490325672, 36161.81919090388, 36770.816145919096, 36917.26165476729, 37335.0, 37470.87587372383, 47014.529854702385, 47566.28650570175, 48936.26595600998, 49126.50873491362, 50353.244701330244, 9087.091290871125, 9236.907630923604, 9498.430094194371, 9581.089796469325, 9824.852627210741, 16313.755293670367, 17313.52835008988, 17859.910700446413, 17893.910530447265, 18026.09869506493, 13300.40148193353, 13519.526816561372, 14671.92664036673, 14954.252287385805, 14984.100953942798, 14399.568012959628, 14624.976251662707, 14634.34145463478, 14997.850021499646, 15263.389464421743, 15126.39494420211, 15148.924255378653, 15275.618109546906, 15608.687826243638, 15746.133962632166, 9374.765630859283, 9387.389819661701, 9489.240860730986, 9496.952515237655, 9510.667126650811, 10567.0, 10686.625968091079, 13716.588502344946, 14131.657492538192, 15107.093574385572], "unit": "score", "name": "jquery.html", "value": 8850.15998368294}, {"lowerIsBetter": false, "replicates": [1281.6988007818168, 1658.9253483593236, 1672.665466906619, 1696.9745453818186, 1699.9660006799863, 6438.163038804954, 7114.395276401506, 7327.303906128923, 7344.118705755303, 7344.4491663125345, 7234.421246300297, 7339.045924029882, 7397.408207343413, 7398.297161769623, 7418.629068546565, 1956.6184594004176, 2006.3479369204995, 2010.3566858605252, 2157.7842215778455, 2205.4376134085787, 1801.0274451796015, 2136.903839327234, 2168.533765240473, 2175.9347219583437, 2180.1933284684687, 2069.244725675125, 2104.410764985799, 2113.1124927530395, 2113.524456997171, 2161.7513985891587, 2179.7384313882358, 2204.603171429142, 2206.646936490154, 2209.458682622768, 2211.524522227721, 2192.78072192781, 2233.3411643565187, 2236.1167338901205, 2247.4718441166315, 2248.7413947396094, 6917.827054323632, 6934.757283495053, 6992.720291188397, 6998.475114366392, 7003.054587630707, 4514.593686568224, 4568.109218702354, 4595.333676616905, 4607.124646317223, 4609.755366051148, 2946.484365236075, 2998.415309014743, 3072.8924487642826, 3074.047045415928, 3076.4616192166504, 979.6571200079986, 983.8917719050899, 988.0662773678877, 1018.1752780248023, 1072.0, 9943.5028248588, 9946.0, 9948.90051099487, 9956.651517196864, 9970.052844979715, 4113.25961326964, 4114.670826333886, 4156.189543039139, 4162.167566486714, 4173.728707633994, 8520.786980325542, 8534.53060081689, 8545.188207120314, 8558.700445484377, 8559.315254779603, 4575.771211439414, 4613.2388155953895, 4616.0, 4619.930701039487, 4624.05206932578, 4200.15996800635, 4227.260229459832, 4230.640395566411, 4231.111466591989, 4234.576542345741, 3142.245860993391, 3504.369213541536, 3512.8946131616094, 3516.0506663201304, 3552.7335449841366, 1034.5654824973528, 1115.9218854680257, 1162.128403697227, 1163.0172504233908, 1171.8183681529376, 1035.1873779083382, 1037.0355569320604, 1097.7036200225893, 1216.385725208764, 1336.3251557963167, 6938.028675985366, 6979.651017449107, 6991.93008069923, 6999.30006999296, 7004.2645522220455, 1093.4860615510697, 1102.729831191347, 1117.6255954255416, 1134.5688638317386, 1139.481535901163, 5495.2856128703015, 5577.3028371453565, 5611.523020543218, 5615.859603509945, 5619.662820230799, 8171.836563268701, 8197.180281971874, 8198.057223419264, 8294.8341033179, 8321.126281740451, 8083.878741818878, 8171.836563268701, 8228.0, 8248.917510824935, 8356.540390278593, 6950.687219075154, 6989.965050174818, 6997.755078572327, 7006.859862802818, 7066.470014748812, 6679.4990375721045, 6766.289539598468, 6804.4216241620015, 6856.622885741132, 6858.0, 7815.491993020435, 7883.7240696575345, 7888.2506161914525, 8022.759317220492, 8045.557494337868, 8022.0373555173755, 8055.879161812461, 8199.71301004462, 8224.136465671018, 8274.544900030556, 6415.615063096229, 6419.903701444388, 6474.1907261592305, 6474.223093228843, 6477.0, 6221.47117495018, 6593.670316484253, 7131.643417829192, 7202.099737532809, 7270.9636451817405, 6623.238327592196, 6675.933240667531, 6736.629485378156, 6808.897866532105, 6883.7590684325805, 6645.1361323027695, 6674.132362792806, 6687.899681504684, 6695.230048544479, 6702.463802895659, 6746.0, 6767.323267673193, 6771.52599318043, 6783.0, 6814.829629259309, 6329.208848893888, 6403.935960640334, 6413.615183089029, 6415.743370265323, 6420.454261387835, 6285.654289014148, 6388.4569811566535, 6388.840278992877, 6389.2652344980925, 6405.167328247298], "unit": "score", "name": "mootools.html", "value": 4285.552591919926}, {"lowerIsBetter": false, "replicates": [325.7833540695437, 329.7872871997562, 340.68486649848893, 341.45196958881013, 345.0820816627769, 5919.08254220596, 5922.585419020665, 5956.01725715257, 5964.671943043131, 6033.818985430444, 5637.605367624268, 5685.118806584976, 5810.535157187415, 5820.912686309698, 5903.380145084769, 4571.565701258383, 4594.793234304448, 4600.861974140781, 4611.239145540982, 4617.861464156081, 4400.669949753766, 4619.53804619537, 4624.491305956342, 4625.79183936722, 4634.142683603527, 4383.890402739941, 4464.910701785979, 4505.504394516601, 4520.0, 4524.547545245482, 4495.955040449587, 4522.479914809806, 4523.185826551219, 4529.026259354222, 4530.546945305476, 3954.070793363586, 3971.245463361981, 3973.284808734427, 3973.324534829086, 3980.144268982183, 5548.889022219573, 5566.972165139189, 5609.35492418373, 5644.774209031634, 5665.575081868877, 5310.654807437504, 5316.9202461963105, 5320.467953204648, 5324.148136298212, 5329.546988505982, 6222.222222222223, 6256.311805701369, 6258.937410625881, 6264.5301602380005, 6285.87428251437, 4469.217886869785, 4475.910481790378, 4479.865604031885, 4482.081173359454, 4498.527654596286, 6388.329225431309, 6535.803925882231, 6550.508711846631, 6552.803415897531, 6557.573757705782, 4539.614132798749, 4549.567791059844, 4549.681522293474, 4552.499225085238, 4560.065186636798, 4585.449746030497, 4592.173408786383, 4592.517785632527, 4594.724316541018, 4595.793189306489, 5279.815206467755, 5288.576913846883, 5298.841034768886, 5306.54894333986, 5309.761060752276, 6145.5698101133385, 6347.1114044033875, 6359.300476947532, 6367.331430199855, 6371.458426033839, 1562.640592663671, 1578.9578877940505, 1579.241963857355, 1581.6599431122363, 1586.8889177757676, 1046.3774054437597, 1074.7152004718755, 1079.5519859258477, 1082.99458502707, 1105.1324710102692, 6062.545309101835, 6084.056971169387, 6087.908681369783, 6093.177421048191, 6110.969445152746, 6542.149520562297, 6548.607083574905, 6549.443297319781, 6550.803475895731, 6558.80323590293, 5902.085176797603, 5982.670953097621, 6066.848328791815, 6089.360617135137, 6099.9390006099375, 3523.295340931824, 3540.7521473497122, 3557.5908770491205, 3561.0385195996937, 3561.0919215600375, 6434.0, 6584.176977877765, 6704.530682852153, 6705.7652982146365, 6708.6310252936555, 6537.411632953057, 6721.361470660279, 6726.764563240263, 6728.629925354153, 6755.088063111417, 6699.564528305645, 6707.3292670732535, 6719.0593316935665, 6720.798376048726, 6720.932790672128, 6461.515386345949, 6598.637074960923, 6601.306862779339, 6601.834954126185, 6613.570117942319, 6469.611823290617, 6483.740650373932, 6484.0, 6493.707783149675, 6514.6416947068365, 6713.395794378529, 6714.3957043866285, 6714.429273511806, 6718.294579069323, 6719.697613607497, 4433.069055498381, 4530.093981203707, 4537.0472200836875, 4537.342085397665, 4552.88617784558, 6553.082568440327, 6578.5395022347975, 6578.967105164444, 6586.110875031809, 6591.406773390418, 6416.743330266737, 6417.711202995783, 6421.357864213542, 6434.0, 6447.387498187664, 6222.62664240147, 6364.459020983269, 6406.615603063831, 6410.967945160244, 6435.09908612804, 6239.812805615838, 6250.718717657807, 6296.590721603265, 6336.3030066693545, 6338.619682819046, 6465.676716164267, 6472.35276472349, 6473.870522589427, 6476.740930362733, 6479.546431749733, 6124.877502449837, 6305.1172835803945, 6313.147725057059, 6321.557490975588, 6322.0], "unit": "score", "name": "prototype.html", "value": 4780.318242335702}, {"lowerIsBetter": false, "replicates": [744.1999850161075, 746.1009483572296, 752.7440670172141, 767.3554214459853, 844.6916875340501, 13974.301284935751, 14202.715945681093, 14227.359768810402, 14249.71500569988, 14252.144871307728, 13217.273049982246, 13242.073054886161, 13273.20360778354, 13289.534866279682, 13349.733005339887, 680.8161796314992, 686.0840777561936, 801.7594721583516, 818.5170749257936, 819.5983967855767, 823.5347028928636, 827.4580150001758, 833.529056083314, 833.9041010283835, 836.1596595421623, 710.9573425594481, 857.4426622695236, 866.3026263857623, 867.7700409391484, 868.622149365025, 696.6029363262942, 703.1702590942685, 705.3510770091502, 840.8276303357796, 856.1737922904427, 629.1694962649304, 631.084926856056, 634.0204384226381, 634.1787385336, 636.9554131210817, 12347.38263086842, 12373.381330933418, 12394.380280986004, 12396.13227074105, 12437.191582547106, 12007.3395963222, 12017.39913004355, 12175.33035683046, 12234.510619575207, 12281.69295767604, 9432.622695092188, 9628.759281017961, 10003.39979601219, 10016.38356464536, 10166.288359814816, 3481.331237261152, 3576.946345804815, 3582.677559019675, 3644.908877278063, 3676.9448458273146, 44269.11461770746, 44372.556274437164, 44534.331985019926, 44663.77668111671, 44730.32904506403, 9275.67535136267, 9647.855282170773, 9801.0, 9885.50572471388, 10418.739531511774, 18148.092595370177, 18286.0, 18311.54221144482, 18502.629947400976, 18546.350877719215, 7397.741079062314, 7452.329290363893, 7629.122650895218, 7677.884831727529, 7830.6084695764985, 4197.937030944478, 4259.2759230930815, 4274.20927128476, 4277.807498662568, 4365.563443655609, 3057.7095175958248, 3084.6606873243927, 3090.196548897303, 3090.969090309113, 3097.7521798256084, 570.164708701754, 576.5290174695211, 578.254052272572, 591.0779184472237, 604.7399618164144, 661.6191262647866, 691.2016620802981, 692.9514933954675, 693.2512290807925, 709.0109297529917, 8991.82016359669, 9065.864012039825, 9082.818343633091, 9389.0, 9517.524123793783, 621.9626822390671, 630.196499463179, 681.5331497923938, 684.7945616315086, 703.2088899987514, 3593.299306635181, 3634.927301454009, 4044.5348784889525, 4153.502006319028, 4159.563245859202, 50776.0, 51296.0, 51814.740926295126, 52029.0, 52421.47578524242, 47903.5209647899, 48327.27509087366, 48830.51169488331, 48846.755766220944, 49272.75363623231, 44571.77714111473, 44651.77674111609, 44802.0, 45075.54924450779, 46117.385891494305, 7618.276263754934, 7738.2261773822165, 7754.291487699064, 7773.883391749016, 7779.144294127755, 33614.0, 35014.47478287879, 35877.82061089678, 36788.44817327688, 37451.81274093612, 42754.358684620376, 43502.34746478868, 43895.34156987584, 44081.0, 44270.557294426646, 10733.302335348177, 11026.44867756625, 11040.171987100839, 11196.0, 11276.758218997084, 11882.524699011943, 12325.568605098779, 12356.25862448256, 12382.442790074649, 13470.93264533671, 11296.177344905485, 11433.542658293574, 11589.768204636028, 11774.352410617155, 12302.507899683913, 11282.492287846902, 11576.421178941187, 11645.825312620149, 11716.0, 11944.462499187384, 10877.857824928586, 11009.394483303495, 11550.249233799776, 11656.708582285512, 11970.042396608425, 9116.361854670375, 9423.340366174301, 9494.525273736148, 9581.751322909493, 9618.0, 9061.0, 9084.954575227346, 9574.377665451724, 9578.329516933747, 9592.328537002342], "unit": "score", "name": "yui.html", "value": 6229.415540533728}], "name": "dromaeo_css", "value": 6960.402037827966}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 105.0, 111.0, 110.0, 111.0, 101.0, 110.0, 110.0, 119.0], "unit": "score", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [158.0, 123.0, 150.0, 166.0, 130.0, 145.0, 144.0, 133.0, 168.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [163.0, 166.0, 162.0, 161.0, 160.0, 160.0, 163.0, 161.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 83.0, 93.0, 70.0, 70.0, 71.0, 106.0, 89.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.8}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 138.0, 94.0, 94.0, 94.0, 141.0, 94.0, 94.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 107.1}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 148.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 60.0, 60.0, 59.0, 59.0, 60.0, 68.0, 56.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.6}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 86.0, 86.0, 86.0, 86.0, 85.0, 85.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [116.0, 115.0, 117.0, 121.0, 121.0, 121.0, 122.0, 125.0, 120.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [144.0, 155.0, 153.0, 154.0, 163.0, 147.0, 154.0, 162.0, 143.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 151.9}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 69.0, 67.0, 67.0, 68.0, 66.0, 67.0, 67.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1508.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.61112962345885], "unit": "score", "name": "Richards", "value": 211.88260400000004}, {"lowerIsBetter": false, "replicates": [189.53752843062927], "unit": "score", "name": "DeltaBlue", "value": 348.8385680000001}, {"lowerIsBetter": false, "replicates": [280.58361391694723], "unit": "score", "name": "Encrypt", "value": 948.6690839999999}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1928.7090558766859], "unit": "score", "name": "RayTrace", "value": 383.67062037962035}, {"lowerIsBetter": false, "replicates": [794.2811755361398], "unit": "score", "name": "Earley", "value": 839.0769169999999}, {"lowerIsBetter": false, "replicates": [12493.827160493827], "unit": "score", "name": "Boyer", "value": 53.34338241106715}, {"lowerIsBetter": false, "replicates": [26342.105263157893], "unit": "score", "name": "RegExp", "value": 34.58284715284714}, {"lowerIsBetter": false, "replicates": [577.0340450086555], "unit": "score", "name": "Splay", "value": 141.22390300000004}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19881.67346582321}]} 17:27:37 INFO - RETURN: dromaeo_css: 6960.40 17:27:37 INFO - RETURN: kraken: 1508.50 17:27:37 INFO - RETURN: v8_7: 19881.67 17:27:37 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19881.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1508.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6960.40"}}} 17:27:37 INFO - Return code: 0 17:27:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 17:27:37 ERROR - # TBPL SUCCESS # 17:27:37 INFO - Running post-action listener: _resource_record_post_action 17:27:37 INFO - Running post-run listener: _resource_record_post_run 17:27:38 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 380928; Write bytes: 309616640; Read time: 276; Write time: 231724 17:27:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 1536000; Read time: 0; Write time: 84 17:27:39 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 380928; Write bytes: 308080640; Read time: 276; Write time: 231640 17:27:39 INFO - Running post-run listener: _upload_blobber_files 17:27:39 INFO - Blob upload gear active. 17:27:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:27:39 INFO - Copying logs to upload dir... 17:27:39 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.537564 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-18 17:27:38.961637) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 17:27:38.964837) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009953 build_url: 'https://queue.taskcluster.net/v1/task/cwSB1xjaTLirKo9X_N7OzA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 17:27:39.019150) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 17:27:39.019751) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450484127.875573-516487758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004673 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 17:27:39.070415) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 17:27:39.070766) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 17:27:39.071130) ========= ========= Total master_lag: 0.26 =========