builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1450421617.62 results: success (0) buildid: 20151217203159 builduid: 95aa36e6844c4dbb8c91fde34e2e9268 revision: e9d5cb555ba74752dea8a5b2e0cedb75c57c82e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:37.615665) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:37.616076) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:37.616373) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006356 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:37.647340) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:37.647619) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:37.662847) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:37.663111) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:37.712759) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:37.713058) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:37.713395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:37.713741) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 22:53:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-12-17 22:53:38 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.297813 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:38.023945) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:38.024273) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017460 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:38.073960) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:38.074329) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev e9d5cb555ba74752dea8a5b2e0cedb75c57c82e4 --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/b2g-inbound --rev e9d5cb555ba74752dea8a5b2e0cedb75c57c82e4 --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=0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 22:53:38,493 truncating revision to first 12 chars 2015-12-17 22:53:38,493 Setting DEBUG logging. 2015-12-17 22:53:38,493 attempt 1/10 2015-12-17 22:53:38,493 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/e9d5cb555ba7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 22:53:39,003 unpacking tar archive at: b2g-inbound-e9d5cb555ba7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.794854 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:38.884903) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:38.885265) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:38.892410) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:38.892686) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 22:53:38.893118) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-17 22:53:38.893410) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 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', 'B2G-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:53:39 INFO - MultiFileLogger online at 20151217 22:53:39 in /builds/slave/test-pgo 22:53:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 22:53:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:53:39 INFO - {'append_to_log': False, 22:53:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:53:39 INFO - 'blob_upload_branch': 'B2G-Inbound', 22:53:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:53:39 INFO - 'branch': 'B2G-Inbound', 22:53:39 INFO - 'buildbot_json_path': 'buildprops.json', 22:53:39 INFO - 'config_files': ('talos/linux_config.py',), 22:53:39 INFO - 'default_actions': ('clobber', 22:53:39 INFO - 'read-buildbot-config', 22:53:39 INFO - 'download-and-extract', 22:53:39 INFO - 'populate-webroot', 22:53:39 INFO - 'create-virtualenv', 22:53:39 INFO - 'install', 22:53:39 INFO - 'run-tests'), 22:53:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:53:39 INFO - 'download_minidump_stackwalk': True, 22:53:39 INFO - 'download_symbols': 'ondemand', 22:53:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:53:39 INFO - 'tooltool.py': '/tools/tooltool.py', 22:53:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:53:39 INFO - '/tools/misc-python/virtualenv.py')}, 22:53:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:53:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:53:39 INFO - 'installer_path': 'installer.exe', 22:53:39 INFO - 'log_level': 'info', 22:53:39 INFO - 'log_name': 'talos', 22:53:39 INFO - 'log_to_console': True, 22:53:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:53:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:53:39 INFO - 'opt_config_files': (), 22:53:39 INFO - 'pip_index': False, 22:53:39 INFO - 'sps_profile': False, 22:53:39 INFO - 'sps_profile_interval': 0, 22:53:39 INFO - 'suite': 'dromaeojs', 22:53:39 INFO - 'system_bits': '64', 22:53:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:53:39 INFO - 'title': 'talos-linux64-ix-035', 22:53:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:53:39 INFO - 'use_talos_json': True, 22:53:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:53:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:53:39 INFO - 'work_dir': 'build'} 22:53:39 INFO - ##### 22:53:39 INFO - ##### Running clobber step. 22:53:39 INFO - ##### 22:53:39 INFO - Running pre-action listener: _resource_record_pre_action 22:53:39 INFO - Running main action method: clobber 22:53:39 INFO - rmtree: /builds/slave/test-pgo/build 22:53:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:53:39 INFO - Running post-action listener: _resource_record_post_action 22:53:39 INFO - ##### 22:53:39 INFO - ##### Running read-buildbot-config step. 22:53:39 INFO - ##### 22:53:39 INFO - Running pre-action listener: _resource_record_pre_action 22:53:39 INFO - Running main action method: read_buildbot_config 22:53:39 INFO - Using buildbot properties: 22:53:39 INFO - { 22:53:39 INFO - "project": "", 22:53:39 INFO - "product": "firefox", 22:53:39 INFO - "script_repo_revision": "production", 22:53:39 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 22:53:39 INFO - "repository": "", 22:53:39 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 22:53:39 INFO - "buildid": "20151217203159", 22:53:39 INFO - "pgo_build": "True", 22:53:39 INFO - "basedir": "/builds/slave/test-pgo", 22:53:39 INFO - "buildnumber": 1064, 22:53:39 INFO - "slavename": "talos-linux64-ix-035", 22:53:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:53:39 INFO - "platform": "ubuntu64_hw", 22:53:39 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 22:53:39 INFO - "branch": "b2g-inbound", 22:53:39 INFO - "repo_path": "integration/b2g-inbound", 22:53:39 INFO - "revision": "e9d5cb555ba74752dea8a5b2e0cedb75c57c82e4", 22:53:39 INFO - "stage_platform": "linux64-pgo", 22:53:39 INFO - "builduid": "95aa36e6844c4dbb8c91fde34e2e9268", 22:53:39 INFO - "slavebuilddir": "test" 22:53:39 INFO - } 22:53:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:53:39 INFO - Running post-action listener: _resource_record_post_action 22:53:39 INFO - ##### 22:53:39 INFO - ##### Running download-and-extract step. 22:53:39 INFO - ##### 22:53:39 INFO - Running pre-action listener: _resource_record_pre_action 22:53:39 INFO - Running main action method: download_and_extract 22:53:39 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:53: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')]} 22:53:39 INFO - https://queue.taskcluster.net/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:53:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/test_packages.json 22:53:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/test_packages.json 22:53:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:53:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:53:40 INFO - Downloaded 1302 bytes. 22:53:40 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:53:40 INFO - Using the following test package requirements: 22:53:40 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:40 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:53:40 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:40 INFO - u'jsshell-linux-x86_64.zip'], 22:53:40 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:53:40 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:40 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:53:40 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:53:40 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:53:40 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:53:40 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:53:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:53:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:40 INFO - https://queue.taskcluster.net/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/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 22:53:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/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 22:53:42 INFO - Downloaded 23119951 bytes. 22:53:42 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 22:53:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:42 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 22:53:43 INFO - Return code: 0 22:53:43 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 22:53: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')]} 22:53:43 INFO - https://queue.taskcluster.net/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:53:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/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 22:53:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/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 22:53:44 INFO - Downloaded 23119951 bytes. 22:53:44 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 22:53:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:53:44 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 22:53:45 INFO - Return code: 0 22:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:45 INFO - https://queue.taskcluster.net/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:53:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/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 22:53:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/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 22:53:47 INFO - Downloaded 11132039 bytes. 22:53:47 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 22:53:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:53:47 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 22:53:47 INFO - Return code: 0 22:53: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')]} 22:53:47 INFO - https://queue.taskcluster.net/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:53:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/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 22:53:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/xHbRko7eTAO9YMqin9qZKA/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 22:53:49 INFO - Downloaded 54643109 bytes. 22:53:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:49 INFO - mkdir: /builds/slave/test-pgo/properties 22:53:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:53:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:53:49 INFO - Contents: 22:53:49 INFO - build_url:https://queue.taskcluster.net/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:53:49 INFO - Running post-action listener: _resource_record_post_action 22:53:49 INFO - Running post-action listener: set_extra_try_arguments 22:53:49 INFO - ##### 22:53:49 INFO - ##### Running populate-webroot step. 22:53:49 INFO - ##### 22:53:49 INFO - Running pre-action listener: _resource_record_pre_action 22:53:49 INFO - Running main action method: populate_webroot 22:53:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:53:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:53:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:53:49 INFO - '--tppagecycles', 22:53:49 INFO - '7'], 22:53:49 INFO - 'tests': ['tsvgm']}}, 22:53:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:53:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:53:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:53:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:53:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:53:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:53:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:49 INFO - 'talos_options': ['--e10s'], 22:53:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:53:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:49 INFO - 'tests': ['damp', 'tps']}, 22:53:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:49 INFO - 'talos_options': ['--e10s'], 22:53:49 INFO - 'tests': ['damp', 'tps']}, 22:53:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:53:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:53:49 INFO - 'other': {'tests': ['a11yr', 22:53:49 INFO - 'ts_paint', 22:53:49 INFO - 'tpaint', 22:53:49 INFO - 'sessionrestore', 22:53:49 INFO - 'sessionrestore_no_auto_restore']}, 22:53:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:53:49 INFO - 'tests': ['a11yr', 22:53:49 INFO - 'ts_paint', 22:53:49 INFO - 'tpaint', 22:53:49 INFO - 'sessionrestore', 22:53:49 INFO - 'sessionrestore_no_auto_restore']}, 22:53:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:53:49 INFO - 'tests': ['a11yr', 22:53:49 INFO - 'ts_paint', 22:53:49 INFO - 'tpaint', 22:53:49 INFO - 'sessionrestore', 22:53:49 INFO - 'sessionrestore_no_auto_restore']}, 22:53:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:53:49 INFO - 'tests': ['a11yr', 22:53:49 INFO - 'ts_paint', 22:53:49 INFO - 'tpaint', 22:53:49 INFO - 'sessionrestore', 22:53:49 INFO - 'sessionrestore_no_auto_restore']}, 22:53:49 INFO - 'other_l64': {'tests': ['a11yr', 22:53:49 INFO - 'ts_paint', 22:53:49 INFO - 'tpaint', 22:53:49 INFO - 'sessionrestore', 22:53:49 INFO - 'sessionrestore_no_auto_restore']}, 22:53:49 INFO - 'other_nol64': {'tests': ['a11yr', 22:53:49 INFO - 'ts_paint', 22:53:49 INFO - 'tpaint', 22:53:49 INFO - 'sessionrestore', 22:53:49 INFO - 'sessionrestore_no_auto_restore']}, 22:53:49 INFO - 'svgr': {'tests': ['tsvgx', 22:53:49 INFO - 'tsvgr_opacity', 22:53:49 INFO - 'tart', 22:53:49 INFO - 'tscrollx', 22:53:49 INFO - 'cart']}, 22:53:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:53:49 INFO - 'tests': ['tsvgx', 22:53:49 INFO - 'tsvgr_opacity', 22:53:49 INFO - 'tart', 22:53:49 INFO - 'tscrollx', 22:53:49 INFO - 'cart']}, 22:53:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:49 INFO - 'tests': ['tp5o']}, 22:53:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:49 INFO - 'talos_options': ['--e10s'], 22:53:49 INFO - 'tests': ['tp5o']}, 22:53:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:49 INFO - 'talos_options': ['--xperf_path', 22:53:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:49 INFO - 'tests': ['tp5n']}, 22:53:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:53:49 INFO - 'talos_options': ['--e10s', 22:53:49 INFO - '--xperf_path', 22:53:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:53:49 INFO - 'tests': ['tp5n']}}, 22:53:49 INFO - 'talos.zip': {'path': '', 22:53:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:53:49 INFO - Running post-action listener: _resource_record_post_action 22:53:49 INFO - ##### 22:53:49 INFO - ##### Running create-virtualenv step. 22:53:49 INFO - ##### 22:53:49 INFO - Running pre-action listener: _resource_record_pre_action 22:53:49 INFO - Running main action method: create_virtualenv 22:53:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:53:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 22:53:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:53:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:53:49 INFO - Using real prefix '/usr' 22:53:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:53:50 INFO - Installing distribute.............................................................................................................................................................................................done. 22:53:52 INFO - Installing pip.................done. 22:53:52 INFO - Return code: 0 22:53:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:53: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')]} 22:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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')]} 22:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15b1be1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1295600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1324350>, '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 0x1325250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:53: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:53: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 pip>=1.5 22:53:52 INFO - Using env: {'DISPLAY': ':0', 22:53:52 INFO - 'HOME': '/home/cltbld', 22:53:52 INFO - 'LANG': 'en_US.UTF-8', 22:53:52 INFO - 'LANGUAGE': 'en_US:en', 22:53:52 INFO - 'LOGNAME': 'cltbld', 22:53:52 INFO - 'MAIL': '/var/mail/cltbld', 22:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:52 INFO - 'MOZ_NO_REMOTE': '1', 22:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:52 INFO - 'NO_EM_RESTART': '1', 22:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:52 INFO - 'SHELL': '/bin/bash', 22:53:52 INFO - 'SHLVL': '1', 22:53:52 INFO - 'TERM': 'linux', 22:53:52 INFO - 'TMOUT': '86400', 22:53:52 INFO - 'USER': 'cltbld', 22:53:52 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 22:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:52 INFO - '_': '/tools/buildbot/bin/python'} 22:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:53:52 INFO - Cleaning up... 22:53:52 INFO - Return code: 0 22:53:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:53: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')]} 22:53:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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')]} 22:53:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53: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', '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 0x7f15b1be1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1295600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1324350>, '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 0x1325250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:53: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:53: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 psutil>=0.7.1 22:53:52 INFO - Using env: {'DISPLAY': ':0', 22:53:52 INFO - 'HOME': '/home/cltbld', 22:53:52 INFO - 'LANG': 'en_US.UTF-8', 22:53:52 INFO - 'LANGUAGE': 'en_US:en', 22:53:52 INFO - 'LOGNAME': 'cltbld', 22:53:52 INFO - 'MAIL': '/var/mail/cltbld', 22:53:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:52 INFO - 'MOZ_NO_REMOTE': '1', 22:53:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:52 INFO - 'NO_EM_RESTART': '1', 22:53:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:52 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:52 INFO - 'SHELL': '/bin/bash', 22:53:52 INFO - 'SHLVL': '1', 22:53:52 INFO - 'TERM': 'linux', 22:53:52 INFO - 'TMOUT': '86400', 22:53:52 INFO - 'USER': 'cltbld', 22:53:52 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 22:53:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:52 INFO - '_': '/tools/buildbot/bin/python'} 22:53:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:52 INFO - Downloading/unpacking psutil>=0.7.1 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53: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 22:53:54 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:53:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:53:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:53:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:54 INFO - Installing collected packages: psutil 22:53:54 INFO - Running setup.py install for psutil 22:53:54 INFO - building 'psutil._psutil_linux' extension 22:53:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:53:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:53:54 INFO - building 'psutil._psutil_posix' extension 22:53:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:53:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:53:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:53:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:53:54 INFO - Successfully installed psutil 22:53:54 INFO - Cleaning up... 22:53:54 INFO - Return code: 0 22:53:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:54 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 0x7f15b1be1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1295600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1324350>, '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 0x1325250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:53:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:53:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:53:54 INFO - Using env: {'DISPLAY': ':0', 22:53:54 INFO - 'HOME': '/home/cltbld', 22:53:54 INFO - 'LANG': 'en_US.UTF-8', 22:53:54 INFO - 'LANGUAGE': 'en_US:en', 22:53:54 INFO - 'LOGNAME': 'cltbld', 22:53:54 INFO - 'MAIL': '/var/mail/cltbld', 22:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:54 INFO - 'MOZ_NO_REMOTE': '1', 22:53:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:54 INFO - 'NO_EM_RESTART': '1', 22:53:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:54 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:54 INFO - 'SHELL': '/bin/bash', 22:53:54 INFO - 'SHLVL': '1', 22:53:54 INFO - 'TERM': 'linux', 22:53:54 INFO - 'TMOUT': '86400', 22:53:54 INFO - 'USER': 'cltbld', 22:53:54 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 22:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:54 INFO - '_': '/tools/buildbot/bin/python'} 22:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:53:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:53:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:53:56 INFO - Installing collected packages: mozsystemmonitor 22:53:56 INFO - Running setup.py install for mozsystemmonitor 22:53:56 INFO - Successfully installed mozsystemmonitor 22:53:56 INFO - Cleaning up... 22:53:56 INFO - Return code: 0 22:53:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:53:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:53:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:53:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:53:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f15b1be1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1295600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1324350>, '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 0x1325250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:53:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:53:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:53:56 INFO - Using env: {'DISPLAY': ':0', 22:53:56 INFO - 'HOME': '/home/cltbld', 22:53:56 INFO - 'LANG': 'en_US.UTF-8', 22:53:56 INFO - 'LANGUAGE': 'en_US:en', 22:53:56 INFO - 'LOGNAME': 'cltbld', 22:53:56 INFO - 'MAIL': '/var/mail/cltbld', 22:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:53:56 INFO - 'MOZ_NO_REMOTE': '1', 22:53:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:53:56 INFO - 'NO_EM_RESTART': '1', 22:53:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:53:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:53:56 INFO - 'SHELL': '/bin/bash', 22:53:56 INFO - 'SHLVL': '1', 22:53:56 INFO - 'TERM': 'linux', 22:53:56 INFO - 'TMOUT': '86400', 22:53:56 INFO - 'USER': 'cltbld', 22:53:56 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 22:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:53:56 INFO - '_': '/tools/buildbot/bin/python'} 22:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:53:57 INFO - Downloading/unpacking blobuploader==1.2.4 22:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:58 INFO - Downloading blobuploader-1.2.4.tar.gz 22:53:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:53:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:53:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:53:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:53:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:53:59 INFO - Downloading docopt-0.6.1.tar.gz 22:53:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:53:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:53:59 INFO - Installing collected packages: blobuploader, requests, docopt 22:53:59 INFO - Running setup.py install for blobuploader 22:53:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:53:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:53:59 INFO - Running setup.py install for requests 22:54:00 INFO - Running setup.py install for docopt 22:54:00 INFO - Successfully installed blobuploader requests docopt 22:54:00 INFO - Cleaning up... 22:54:00 INFO - Return code: 0 22:54:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:00 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 0x7f15b1be1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1295600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1324350>, '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 0x1325250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:54:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:54:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:54:00 INFO - Using env: {'DISPLAY': ':0', 22:54:00 INFO - 'HOME': '/home/cltbld', 22:54:00 INFO - 'LANG': 'en_US.UTF-8', 22:54:00 INFO - 'LANGUAGE': 'en_US:en', 22:54:00 INFO - 'LOGNAME': 'cltbld', 22:54:00 INFO - 'MAIL': '/var/mail/cltbld', 22:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:00 INFO - 'MOZ_NO_REMOTE': '1', 22:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:00 INFO - 'NO_EM_RESTART': '1', 22:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:00 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:00 INFO - 'SHELL': '/bin/bash', 22:54:00 INFO - 'SHLVL': '1', 22:54:00 INFO - 'TERM': 'linux', 22:54:00 INFO - 'TMOUT': '86400', 22:54:00 INFO - 'USER': 'cltbld', 22:54:00 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 22:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:00 INFO - '_': '/tools/buildbot/bin/python'} 22:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:00 INFO - Running setup.py (path:/tmp/pip-gagX_D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:00 INFO - Running setup.py (path:/tmp/pip-2kEyWc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:00 INFO - Running setup.py (path:/tmp/pip-6ZRtSk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:00 INFO - Running setup.py (path:/tmp/pip-neoyoA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:00 INFO - Running setup.py (path:/tmp/pip-ehSacb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:00 INFO - Running setup.py (path:/tmp/pip-11k2hc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:00 INFO - Running setup.py (path:/tmp/pip-6dqW8y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:00 INFO - Running setup.py (path:/tmp/pip-wukrnc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:00 INFO - Running setup.py (path:/tmp/pip-kOc54G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:01 INFO - Running setup.py (path:/tmp/pip-7Juzy4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:01 INFO - Running setup.py (path:/tmp/pip-Oe3Bv_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:01 INFO - Running setup.py (path:/tmp/pip-xT5xr1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:01 INFO - Running setup.py (path:/tmp/pip-tBO2L9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:01 INFO - Running setup.py (path:/tmp/pip-AvSsP1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:01 INFO - Running setup.py (path:/tmp/pip-3a_39S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:01 INFO - Running setup.py (path:/tmp/pip-PhjPrG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:01 INFO - Running setup.py (path:/tmp/pip-BdVMnv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:54:01 INFO - Running setup.py install for manifestparser 22:54:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:54:01 INFO - Running setup.py install for mozcrash 22:54:01 INFO - Running setup.py install for mozdebug 22:54:01 INFO - Running setup.py install for mozdevice 22:54:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:54:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:54:02 INFO - Running setup.py install for mozfile 22:54:02 INFO - Running setup.py install for mozhttpd 22:54:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:54:02 INFO - Running setup.py install for mozinfo 22:54:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:54:02 INFO - Running setup.py install for mozInstall 22:54:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:54:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:54:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:54:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:54:02 INFO - Running setup.py install for mozleak 22:54:02 INFO - Running setup.py install for mozlog 22:54:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:54:02 INFO - Running setup.py install for moznetwork 22:54:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:54:02 INFO - Running setup.py install for mozprocess 22:54:02 INFO - Running setup.py install for mozprofile 22:54:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:54:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:54:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:54:02 INFO - Running setup.py install for mozrunner 22:54:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:54:03 INFO - Running setup.py install for mozscreenshot 22:54:03 INFO - Running setup.py install for moztest 22:54:03 INFO - Running setup.py install for mozversion 22:54:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:54:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:54:03 INFO - Cleaning up... 22:54:03 INFO - Return code: 0 22:54:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:54: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')]} 22:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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')]} 22:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54: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/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 0x7f15b1be1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1295600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1324350>, '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 0x1325250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:54: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/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:54: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/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:54:03 INFO - Using env: {'DISPLAY': ':0', 22:54:03 INFO - 'HOME': '/home/cltbld', 22:54:03 INFO - 'LANG': 'en_US.UTF-8', 22:54:03 INFO - 'LANGUAGE': 'en_US:en', 22:54:03 INFO - 'LOGNAME': 'cltbld', 22:54:03 INFO - 'MAIL': '/var/mail/cltbld', 22:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:03 INFO - 'MOZ_NO_REMOTE': '1', 22:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:03 INFO - 'NO_EM_RESTART': '1', 22:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:03 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:03 INFO - 'SHELL': '/bin/bash', 22:54:03 INFO - 'SHLVL': '1', 22:54:03 INFO - 'TERM': 'linux', 22:54:03 INFO - 'TMOUT': '86400', 22:54:03 INFO - 'USER': 'cltbld', 22:54:03 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 22:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:03 INFO - '_': '/tools/buildbot/bin/python'} 22:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:03 INFO - Running setup.py (path:/tmp/pip-dKU430-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:54:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:03 INFO - Running setup.py (path:/tmp/pip-QG5nX4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:54:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:03 INFO - Running setup.py (path:/tmp/pip-FPDiWf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:54:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:03 INFO - Running setup.py (path:/tmp/pip-aX3bef-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:54:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:54:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:03 INFO - Running setup.py (path:/tmp/pip-0SBMvY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 22:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:04 INFO - Running setup.py (path:/tmp/pip-bfuqaP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 22:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:04 INFO - Running setup.py (path:/tmp/pip-NrZonO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 22:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:04 INFO - Running setup.py (path:/tmp/pip-OrlxSU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 22:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:04 INFO - Running setup.py (path:/tmp/pip-qSYxwB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:04 INFO - Running setup.py (path:/tmp/pip-BKTU5l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:04 INFO - Running setup.py (path:/tmp/pip-l6kYAh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:04 INFO - Running setup.py (path:/tmp/pip-5e9l4Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:04 INFO - Running setup.py (path:/tmp/pip-36gNVi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:04 INFO - Running setup.py (path:/tmp/pip-NEDypi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:04 INFO - Running setup.py (path:/tmp/pip-1u8QQA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:04 INFO - Running setup.py (path:/tmp/pip-3Oc8sS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 22:54:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:04 INFO - Running setup.py (path:/tmp/pip-Ci_Y18-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:54:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:54:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:06 INFO - Downloading blessings-1.5.1.tar.gz 22:54:06 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 22:54:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:54:06 INFO - Installing collected packages: blessings 22:54:06 INFO - Running setup.py install for blessings 22:54:06 INFO - Successfully installed blessings 22:54:06 INFO - Cleaning up... 22:54:06 INFO - Return code: 0 22:54:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:54:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:54:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:54:06 INFO - Reading from file tmpfile_stdout 22:54:06 INFO - Current package versions: 22:54:06 INFO - argparse == 1.2.1 22:54:06 INFO - blessings == 1.5.1 22:54:06 INFO - blobuploader == 1.2.4 22:54:06 INFO - docopt == 0.6.1 22:54:06 INFO - manifestparser == 1.1 22:54:06 INFO - mozInstall == 1.12 22:54:06 INFO - mozcrash == 0.16 22:54:06 INFO - mozdebug == 0.1 22:54:06 INFO - mozdevice == 0.47 22:54:06 INFO - mozfile == 1.2 22:54:06 INFO - mozhttpd == 0.7 22:54:06 INFO - mozinfo == 0.9 22:54:06 INFO - mozleak == 0.1 22:54:06 INFO - mozlog == 3.1 22:54:06 INFO - moznetwork == 0.27 22:54:06 INFO - mozprocess == 0.22 22:54:06 INFO - mozprofile == 0.27 22:54:06 INFO - mozrunner == 6.11 22:54:06 INFO - mozscreenshot == 0.1 22:54:06 INFO - mozsystemmonitor == 0.0 22:54:06 INFO - moztest == 0.7 22:54:06 INFO - mozversion == 1.4 22:54:06 INFO - psutil == 3.1.1 22:54:06 INFO - requests == 1.2.3 22:54:06 INFO - wsgiref == 0.1.2 22:54:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:06 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 0x7f15b1be1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1295600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1324350>, '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 0x1325250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:54:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 22:54:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:54:06 INFO - Using env: {'DISPLAY': ':0', 22:54:06 INFO - 'HOME': '/home/cltbld', 22:54:06 INFO - 'LANG': 'en_US.UTF-8', 22:54:06 INFO - 'LANGUAGE': 'en_US:en', 22:54:06 INFO - 'LOGNAME': 'cltbld', 22:54:06 INFO - 'MAIL': '/var/mail/cltbld', 22:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:06 INFO - 'MOZ_NO_REMOTE': '1', 22:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:06 INFO - 'NO_EM_RESTART': '1', 22:54:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:06 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:06 INFO - 'SHELL': '/bin/bash', 22:54:06 INFO - 'SHLVL': '1', 22:54:06 INFO - 'TERM': 'linux', 22:54:06 INFO - 'TMOUT': '86400', 22:54:06 INFO - 'USER': 'cltbld', 22:54:06 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 22:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:06 INFO - '_': '/tools/buildbot/bin/python'} 22:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 22:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 22:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 22:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 22:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 22:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 22:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 22:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 22:54:07 INFO - Cleaning up... 22:54:07 INFO - Return code: 0 22:54:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15b1be1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1295600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1324350>, '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 0x1325250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:54:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 22:54:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:54:07 INFO - Using env: {'DISPLAY': ':0', 22:54:07 INFO - 'HOME': '/home/cltbld', 22:54:07 INFO - 'LANG': 'en_US.UTF-8', 22:54:07 INFO - 'LANGUAGE': 'en_US:en', 22:54:07 INFO - 'LOGNAME': 'cltbld', 22:54:07 INFO - 'MAIL': '/var/mail/cltbld', 22:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:07 INFO - 'MOZ_NO_REMOTE': '1', 22:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:07 INFO - 'NO_EM_RESTART': '1', 22:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:07 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:07 INFO - 'SHELL': '/bin/bash', 22:54:07 INFO - 'SHLVL': '1', 22:54:07 INFO - 'TERM': 'linux', 22:54:07 INFO - 'TMOUT': '86400', 22:54:07 INFO - 'USER': 'cltbld', 22:54:07 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 22:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:07 INFO - '_': '/tools/buildbot/bin/python'} 22:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:07 INFO - Downloading/unpacking jsonschema 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54: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 22:54:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:54:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 22:54:09 INFO - Downloading/unpacking functools32 (from jsonschema) 22:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:09 INFO - Downloading functools32-3.2.3-2.tar.gz 22:54:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:54:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:54:09 INFO - warning: no files found matching '*.txt' 22:54:09 INFO - no previously-included directories found matching 'build' 22:54:09 INFO - no previously-included directories found matching 'dist' 22:54:09 INFO - no previously-included directories found matching '.git*' 22:54:09 INFO - Installing collected packages: jsonschema, functools32 22:54:09 INFO - Running setup.py install for functools32 22:54:09 INFO - warning: no files found matching '*.txt' 22:54:09 INFO - no previously-included directories found matching 'build' 22:54:09 INFO - no previously-included directories found matching 'dist' 22:54:09 INFO - no previously-included directories found matching '.git*' 22:54:09 INFO - Successfully installed jsonschema functools32 22:54:09 INFO - Cleaning up... 22:54:09 INFO - Return code: 0 22:54:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:54:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f15b1be1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11c88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1295600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1324350>, '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 0x1325250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13256e0>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:54:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:54:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:54:09 INFO - Using env: {'DISPLAY': ':0', 22:54:09 INFO - 'HOME': '/home/cltbld', 22:54:09 INFO - 'LANG': 'en_US.UTF-8', 22:54:09 INFO - 'LANGUAGE': 'en_US:en', 22:54:09 INFO - 'LOGNAME': 'cltbld', 22:54:09 INFO - 'MAIL': '/var/mail/cltbld', 22:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:09 INFO - 'MOZ_NO_REMOTE': '1', 22:54:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:09 INFO - 'NO_EM_RESTART': '1', 22:54:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:09 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:09 INFO - 'SHELL': '/bin/bash', 22:54:09 INFO - 'SHLVL': '1', 22:54:09 INFO - 'TERM': 'linux', 22:54:09 INFO - 'TMOUT': '86400', 22:54:09 INFO - 'USER': 'cltbld', 22:54:09 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 22:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:09 INFO - '_': '/tools/buildbot/bin/python'} 22:54:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:54:09 INFO - Downloading/unpacking flake8 22:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:54:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 22:54:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:54:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 22:54:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 22:54:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:54:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:54:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:54:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:54:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:54:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:12 INFO - no previously-included directories found matching 'docs/_build' 22:54:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:54:12 INFO - Running setup.py install for pep8 22:54:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:54:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:54:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:54:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:54:12 INFO - no previously-included directories found matching 'docs/_build' 22:54:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:54:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:54:12 INFO - Cleaning up... 22:54:12 INFO - Return code: 0 22:54:12 INFO - Running post-action listener: _resource_record_post_action 22:54:12 INFO - Running post-action listener: _start_resource_monitoring 22:54:12 INFO - Starting resource monitoring. 22:54:12 INFO - ##### 22:54:12 INFO - ##### Running install step. 22:54:12 INFO - ##### 22:54:12 INFO - Running pre-action listener: _resource_record_pre_action 22:54:12 INFO - Running main action method: install 22:54:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:54:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:54:12 INFO - Reading from file tmpfile_stdout 22:54:12 INFO - Detecting whether we're running mozinstall >=1.0... 22:54:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:54:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:54:12 INFO - Reading from file tmpfile_stdout 22:54:12 INFO - Output received: 22:54:12 INFO - Usage: mozinstall [options] installer 22:54:12 INFO - Options: 22:54:12 INFO - -h, --help show this help message and exit 22:54:12 INFO - -d DEST, --destination=DEST 22:54:12 INFO - Directory to install application into. [default: 22:54:12 INFO - "/builds/slave/test-pgo"] 22:54:12 INFO - --app=APP Application being installed. [default: firefox] 22:54:12 INFO - mkdir: /builds/slave/test-pgo/build/application 22:54:12 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'] 22:54:12 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 22:54:28 INFO - Reading from file tmpfile_stdout 22:54:28 INFO - Output received: 22:54:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:54:28 INFO - Running post-action listener: _resource_record_post_action 22:54:28 INFO - ##### 22:54:28 INFO - ##### Running run-tests step. 22:54:28 INFO - ##### 22:54:28 INFO - Running pre-action listener: _resource_record_pre_action 22:54:28 INFO - Running main action method: run_tests 22:54:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:54:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:54:28 INFO - Python 2.7.3 22:54:28 INFO - Return code: 0 22:54:28 INFO - grabbing minidump binary from tooltool 22:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:54:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1324350>, '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 0x1325250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13256e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:54:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 22:54:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:54:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:54:28 INFO - Return code: 0 22:54:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:54:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:54:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:54:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:54:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:54:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:54:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:54:29 INFO - Return code: 0 22:54:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 22:54:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost 22:54:29 INFO - Using env: {'DISPLAY': ':0', 22:54:29 INFO - 'HOME': '/home/cltbld', 22:54:29 INFO - 'LANG': 'en_US.UTF-8', 22:54:29 INFO - 'LANGUAGE': 'en_US:en', 22:54:29 INFO - 'LOGNAME': 'cltbld', 22:54:29 INFO - 'MAIL': '/var/mail/cltbld', 22:54:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:54:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:54:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:54:29 INFO - 'MOZ_NO_REMOTE': '1', 22:54:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:54:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:54:29 INFO - 'NO_EM_RESTART': '1', 22:54:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:54:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:54:29 INFO - 'PWD': '/builds/slave/test-pgo', 22:54:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:54:29 INFO - 'SHELL': '/bin/bash', 22:54:29 INFO - 'SHLVL': '1', 22:54:29 INFO - 'TERM': 'linux', 22:54:29 INFO - 'TMOUT': '86400', 22:54:29 INFO - 'USER': 'cltbld', 22:54:29 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698', 22:54:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:54:29 INFO - '_': '/tools/buildbot/bin/python'} 22:54:29 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost'] with output_timeout 3600 22:54:29 INFO - mozversion INFO | application_buildid: 20151217203159 22:54:29 INFO - mozversion INFO | application_changeset: e9d5cb555ba74752dea8a5b2e0cedb75c57c82e4 22:54:29 INFO - mozversion INFO | application_display_name: Nightly 22:54:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:54:29 INFO - mozversion INFO | application_name: Firefox 22:54:29 INFO - mozversion INFO | application_remotingname: firefox 22:54:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 22:54:29 INFO - mozversion INFO | application_vendor: Mozilla 22:54:29 INFO - mozversion INFO | application_version: 46.0a1 22:54:29 INFO - mozversion INFO | platform_buildid: 20151217203159 22:54:29 INFO - mozversion INFO | platform_changeset: e9d5cb555ba74752dea8a5b2e0cedb75c57c82e4 22:54:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 22:54:29 INFO - mozversion INFO | platform_version: 46.0a1 22:54:29 INFO - 2015-12-17 22:54:29,606 DEBUG : using testdate: 1450421669 22:54:29 INFO - 2015-12-17 22:54:29,606 DEBUG : actual date: 1450421669 22:54:29 INFO - 2015-12-17 22:54:29,615 INFO : starting webserver on 'localhost:56913' 22:54:29 INFO - 2015-12-17 22:54:29,616 INFO : Starting test suite talos-linux64-ix-035 22:54:29 INFO - 2015-12-17 22:54:29,616 INFO : Starting test dromaeo_css 22:54:29 INFO - 2015-12-17 22:54:29,616 DEBUG : operating with platform_type : linux_ 22:54:29 INFO - 2015-12-17 22:54:29,617 INFO : Initialising browser for dromaeo_css test... 22:54:29 INFO - 2015-12-17 22:54:29,633 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjYV896/profile http://localhost:56913/getInfo.html 22:54:33 INFO - 2015-12-17 22:54:33,590 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:54:33 INFO - 2015-12-17 22:54:33,591 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:54:33 INFO - 2015-12-17 22:54:33,591 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:54:33 INFO - 2015-12-17 22:54:33,591 DEBUG : BROWSER_OUTPUT: __metrics 22:54:33 INFO - 2015-12-17 22:54:33,687 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] 22:54:33 INFO - 2015-12-17 22:54:33,743 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] 22:54:34 INFO - 2015-12-17 22:54:34,639 INFO : Browser initialized. 22:54:34 INFO - 2015-12-17 22:54:34,639 INFO : Running cycle 1/1 for dromaeo_css test... 22:54:34 INFO - 2015-12-17 22:54:34,639 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjYV896/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:54:46 INFO - 2015-12-17 22:54:46,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 149606400 22:54:46 INFO - 2015-12-17 22:54:46,403 DEBUG : BROWSER_OUTPUT: 22:55:37 INFO - 2015-12-17 22:55:37,796 DEBUG : BROWSER_OUTPUT: 1450421737795 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:57:46 INFO - 2015-12-17 22:57:46,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56913/tests/dromaeo/cssquery-ext.html) 22:57:47 INFO - 2015-12-17 22:57:47,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 278757376 22:57:47 INFO - 2015-12-17 22:57:47,677 DEBUG : BROWSER_OUTPUT: 23:00:50 INFO - 2015-12-17 23:00:50,248 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/dromaeo/cssquery-ext.html (next: http://localhost:56913/tests/dromaeo/cssquery-jquery.html) 23:00:50 INFO - 2015-12-17 23:00:50,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 230215680 23:00:50 INFO - 2015-12-17 23:00:50,814 DEBUG : BROWSER_OUTPUT: 23:03:52 INFO - 2015-12-17 23:03:52,757 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56913/tests/dromaeo/cssquery-mootools.html) 23:03:53 INFO - 2015-12-17 23:03:53,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 227741696 23:03:53 INFO - 2015-12-17 23:03:53,331 DEBUG : BROWSER_OUTPUT: 23:06:55 INFO - 2015-12-17 23:06:55,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56913/tests/dromaeo/cssquery-prototype.html) 23:06:55 INFO - 2015-12-17 23:06:55,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 210075648 23:06:55 INFO - 2015-12-17 23:06:55,803 DEBUG : BROWSER_OUTPUT: 23:09:58 INFO - 2015-12-17 23:09:58,279 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56913/tests/dromaeo/cssquery-yui.html) 23:09:58 INFO - 2015-12-17 23:09:58,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 217776128 23:09:58 INFO - 2015-12-17 23:09:58,862 DEBUG : BROWSER_OUTPUT: 23:13:01 INFO - 2015-12-17 23:13:01,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/dromaeo/cssquery-yui.html (next: http://localhost:56913/tests/dromaeo/cssquery-dojo.html) 23:13:01 INFO - 2015-12-17 23:13:01,835 DEBUG : BROWSER_OUTPUT: RSS: Main: 318066688 23:13:01 INFO - 2015-12-17 23:13:01,836 DEBUG : BROWSER_OUTPUT: 23:13:01 INFO - 2015-12-17 23:13:01,836 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:13:01 INFO - 2015-12-17 23:13:01,836 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:13:01 INFO - 2015-12-17 23:13:01,836 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:13:01 INFO - 2015-12-17 23:13:01,836 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:13:01 INFO - 2015-12-17 23:13:01,837 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3134.8589313480893;3157.242261857155;3169.207698075481;3205.1987003249187;3231.2729635831934;5070.23946408039;5206.45332240115;5257.92113118303;5324.840254792358;5378.677279363241;5200.245964335169;5208.114620514512;5220.686758794475;5255;5300.628955973083;4779.115863565243;4794.32879396883;4803.423589169304;4869.561739443449;4880.609551235911;4790.952090479085;4843.467218605951;4851.684640498374;4871.805127794902;4931.013797240548;4723.929141062904;4751.809927602892;4788.11419887322;4799.184138696395;4822.565969062801;4818.807247710088;4823.421189457253;4848.539388758062;4856.878578035542;4881.243407271879;4746.596539294164;4806.086843499724;4810.903781924377;4817.78319975602;4874.195757699975;5148.2020286855595;5150.021495915764;5157.381114266312;5173.896522069537;5176.870578235575;5696.629719068289;5733.483986441199;5753.654780713171;5808.535317174616;5808.97095514524;5731.914021289643;5808.215890854765;5817.243758311435;5818.8254352369495;5882.323532793741;5396.865078373033;5405.4324295949145;5408.486193811582;5414.187871819219;5415.891682166334;5650.576206784508;5683;5788.594798364074;5816.47651711348;5823.79616713413;5590.972045139748;5641.069223578145;5664.745086471119;5665.291838520185;5665.745041473144;5750.5112065474905;5756.510696590837;5758.107493338539;5761.971190144106;5768.307803063575;5617.43825617435;5623.381428042912;5700.515456186271;5777.508911742465;5795.623284486495;5653.2085508028085;5657;5662.68855212959;5678.716064196857;5709.058005429058;4358.912821743547;4359.411479450297;4376.387305777193;4379.715318504287;4402.207602631557;3873.1866308075055;3920.7059470539825;3921.5490218624655;3949.269385163754;3957.149212919236;5228.738563071831;5294.391145018295;5295.523402893758;5302.522772950453;5303.920441193385;5625.71871406428;5664.97167514168;5678.205051292823;5678.488935995698;5689.715514224272;5103.438621751604;5150.562202212779;5205.063088644005;5215.24378965048;5281.339832520935;4808.182608956486;4891.217405215149;4905.092557876804;4936.90126197474;4938.58022068121;5699.059655156935;5700.743466544015;5702.087665973424;5718.68547229898;5792.623479473821;5575.77696892136;5590.329160500766;5613.803516876889;5656.095024796013;5683.346415162309;5686.573506987075;5704.857378565569;5710.628809127394;5712.6001179917;5801.071828507418;5579.107342825128;5624.606277560695;5633.802816901389;5639.956608027528;5642.915356269741;5666.801661941812;5719.28508936383;5734.369219385948;5744.712764361681;5751;5392.164214546751;5492.4507549246355;5500.009998200202;5579.860503487445;5601.80393686219;5447.64590301645;5494.80768173112;5495.917561236664;5501.0648189807025;5538.833834984957;5430.185472179205;5439.374471935778;5442.102053161184;5444.074507333842;5467.17992301158;5513.338399391938;5523.861903452445;5579.525740311957;5582.860428489158;5588.3573389060775;5468.3437987440175;5532.28080349552;5532.612717109763;5536.640118392292;5578.776848925998 23:13:01 INFO - 2015-12-17 23:13:01,838 DEBUG : BROWSER_OUTPUT: |1;ext.html;567.775728587208;601.5067644531481;602.5059451249971;611.3244864424811;618.601002353482;29911.700882991165;30864.53703194451;38623.613763862355;38991.41512877302;39022;43666.34500482487;43917;43957.340639890426;44178.33732494007;44259;8750.387472876886;8952.776180595505;8960.23837973773;8963.10368963105;8963.148500892405;7810.218978102201;7971.163027882076;10580.947095264513;10900.890991090067;10903.127749780038;10529.52617132227;10599.682009539727;10652.573897044109;10657.253992220547;10671.35971841692;7878.1727918568295;10519.368837869752;10590.570273013122;10615.416152111631;10627.78744425115;7762.650680719381;10649.57401703931;10901.83647245292;10920.18098642597;10927.617533386372;39192.804035979636;39680;39743.8012809937;39781.40327895084;39796.403053954215;3353.4299169141304;3549.9112522186892;3862.3347853513246;3996.480457540501;4029.174019326031;30166.698333016608;30373.392532149453;30528.54207186894;30646.540301895267;31281;3924.6271604197555;3925.1560914403253;4067.491563554556;4081.08175660477;4082.448869402622;267881;268157;268221;268261;268749;55513.2813710831;56955.14567281494;63794.68102659457;65584.34415655877;65752.67123664447;59052;59282.703586482654;59420.7028964861;59600.403995960354;59726;13903.09629874055;14167.149971001567;14230.288485575888;14260.144391336553;14272.571822845332;9813.509324533745;10004.249681273788;10457.84313235302;10694.62568810088;10712.89287107119;19359.225630974885;19449.277101205844;19516.336018136106;19530.902345488466;19579.09083221827;7955.641996110189;8022.478538894953;8102.7569172924905;8137.674493020213;8177.509349439053;959.2469911119738;988.0909563201872;1037.823569993103;1052.5053224984244;1076.0046956565145;28483;28853.56719649207;29161.270968225963;29185.708142918298;29667.406651867273;1020.6733845169623;1033.509083185481;1040.78143589847;1097.8078836203792;1125.482278152043;13885.72706712723;14495.420183192766;14496.245713314436;14716.264186790617;14755.262236888113;323577;328837;328880;329973;330505;52023.21965170526;52141.7392913033;52347.47652523426;52435;52436.47563524392;1337.6321511584392;1362.0669841158838;1374.752544541972;1381.040177076922;1384.2940100548792;27360.315992100357;28278.293042674097;28294.434111317245;29922.401551969273;31107.68892311048;47847.52152478431;48296.5170348292;48399.27401089057;48460;48476.5152348472;242323;243418;245331;246410;246516;28821.279468012628;29096.127116186548;31440.213994650316;32614.34771304608;33169;38028.2394352117;38461.038474038374;38747;39103.21793564056;39588.20823583454;34957.65042349544;35199.82400087983;35480.46779298364;35482.645173547935;36704.81647591745;35415;36031.099222519646;36201.637983619825;36227.63772362243;36310.45534316934;31760.36479270448;31885.521717173797;36466.27067458583;37098.258034839695;37266.62733372632;28814.423711526073;32428.189295267806;34120.317593648484;34171;34469.482957756154;23407.76592234124;24689.135880244106;24734.628980565667;25288.241352759447;25291.49417011686 23:13:01 INFO - 2015-12-17 23:13:01,842 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.7178257394084;353.52980535887264;356.16124027914253;357.65486305714995;359.2097385751348;14732.779008314883;14980.998037705876;15758;16345.75481367779;17340.393086242;13557.389917453713;14305.642358941006;16066.919665401685;16455.09496977666;16506.66986660266;5376.220448035042;5456.836294911139;5498.45015498451;5500.339959204901;5502.532284755781;3724.590295067554;3825.5026846510054;5114.181730923053;5291.2327712481665;5425.538829199503;5299.54953828925;5489.725513724317;5506.174073888908;5506.284183056197;5510.448955104497;5055.51972562606;5222.529972302511;5474.39781624021;5493.972530137344;5494.120940649497;5000.449950505442;5020.4226513951;5028.673136246132;5029.7736601853;5034.496550344973;11866.406679665983;12042.277463352228;18509.16708748096;19675.016249187483;20169.596608067757;1745.519982004946;1860.3302810988034;1957.784643689193;1996.800319968006;2148.602508535926;9530.428174309563;9663.758406039835;9672.516374181263;9749.512524373753;9896.55465504054;1819.0995457248746;1832.0748022248813;1869.6541139889164;1872.3259626534436;1877.474307193988;57758.42241577573;60472.69763651198;60503.697481512754;60925.39074609242;61305.38694613041;9936.652217172508;10188.490575471345;10325.9483702581;10349.534270957674;10412.68761937143;13504.594862154152;13570.253636050113;13574.524891628746;13622;13630;7166.820829479305;7198.676059577331;7246.311600397954;7273.381762550137;7354.191038985708;6750.8649827004165;6860.622665753432;6864.1762988440705;6870.7595234166565;6972.442204623618;4396.362527433568;4458.77706114693;4462.509123996358;4491.258942274553;4501.2347900856275;1687.5612340791483;1713.3146741303578;1784.3843873863495;1794.425783749214;1801.7567628370002;893.9553022348856;906.6600024990629;974.9951250243703;998.3610489286863;1058.6929790360864;15385.382540228655;16319.91840040816;16972.49082527526;17078.573035674206;17261.223244954006;865.5066612031081;921.5714692667808;922.7139586728135;925.1349987761464;937.3063932689897;9365.578548965314;9650.420974741539;9950.552225149886;10068.899311006942;10177;415240;417566;420264;423342;562481;77330.69196539684;79362.60318698485;81588.18411815805;81876;83215;1182.266994463421;1182.3497076608003;1207.897328727068;1225.6200577820905;1236.5486597392066;10386;15442.22788860575;15584.220788960733;15704;15844.207789610244;34236.657633424344;36117.27765444624;36221;36566.63433365632;37147;25667.614985774853;36625;44359.669209923755;46649.30026049544;53504.73247633737;13759.449622015407;14055.718885622025;14220.288985550887;14235.50175743844;14947.103173809606;10734.946325268324;11203.43982800873;11696.06431485462;11745.530178792753;17160.399386021927;9829.262805289489;9882.357646752938;10016.499175041365;10387.94806025965;10396.116330111723;9855.605775768889;10103.393796371947;10604.681859544226;10612.575496980344;10691.037806597444;10021.39871607706;10021.649242276486;10025.5488503019;10482.895171048192;10555.261131721012;14753.92623036878;15018.324175411914;15055.698886022437;15192.392304307705;15270.923645381701;15012.699746005237;15595.84404155944;15923.840761592699;15974.8402515978;16521.091339976418 23:13:01 INFO - 2015-12-17 23:13:01,842 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1089.4226060188103;1453.7165252775708;1520.247477498638;1628.918554072296;1747.7727895373607;6725.79822605322;7354.669039893204;7527.059117610299;7533.472656914018;7553.811154721135;7438.256174382559;7448.7392941246935;7518.323350898418;7525.209852965429;7528;1936.8741031832885;1971.2903354792263;2173.6739489076685;2195.5938151442033;2207.6578130389817;2206.580749657568;2237.7090978172814;2238.5187184755273;2239.2162743039967;2240.8543444676043;2150.4516348331153;2183.6833659119497;2204.1403852497538;2206.8013878750908;2209.149477451185;1921.730957665928;1952.9609407811836;2201.4826515768864;2210.24851550472;2234.55308938213;2153.752318483379;2174.8151407130254;2176.9346919592435;2183.5960347335795;2184.5084855907453;7487.737929172453;7545.584992825392;7566.432517561205;7567.281108294758;7573.772786816405;4474.284114541658;4498.865034048984;4515.074409745994;4530.184566777979;4562.156001139767;3005.2637103909683;3029.621297337833;3054.312779624589;3054.618172728409;3115.5793967814284;1007.8588997540351;1016.4561959351711;1032.726327523207;1060.2207377577474;1065.984010239847;9804.656837010742;9828.262880284008;9835.655752048715;9836.606535738561;9837.950810245975;3991.7405368650943;4019.2162528307285;4078.4494093297617;4163.979180104141;4174.812133454002;8488.320934325238;8502.74491765248;8531.06158322584;8545.74362769118;8555.957220213984;4563.361129441881;4585.312203169551;4590.88522786933;4593.586577208067;4598.793054312564;4111.198316328347;4176.331786914079;4177.248095342868;4192.580741925783;4200.537940826506;3474.965250347515;3501.632328605511;3513.0339156731593;3517.50754894315;3549.0594992327055;1088.5373716170595;1111.372074777748;1115.642994241851;1121.942706125817;1129.9096372000895;1314.677903913528;1315.3620494060374;1337.6588969812635;1349.2579081505132;1355.620426280643;6272.968635156886;6541.771038013647;7134.286571342825;7158.391536719333;7160.713571457188;599.7960693364278;606.5693357715983;612.5865041097242;627.9937200627935;631.5768435148461;5514.834554963358;5552.91670624941;5571.777128914879;5587.916181257285;5610.214569960209;8710.69512567057;8815.338849586307;8829.205371516466;8931.19619234272;8943.060978597283;8714.91285087141;8722.912770872337;8733.956330218436;8798.824023519493;8826.86759698605;6828.419584335288;7026.051483049723;7036.718531258794;7070.505064645528;7098;6872.072270243453;6892.241853396022;6905.723771049303;6915.273896241023;6916.861662766616;7686.116096648957;7914.564698941614;7919.049714034353;8015.959920200595;8066.798330041796;7456.552606843607;7581.355584775356;7581.658825352762;7722.575258360619;7722.845543089219;6128.8774224516155;6349.460295874717;6354.841128971628;6357.841053973688;6747.359000894907;6927.1989282787845;6976.337247961435;6980.685869136003;6981.406580440719;6984.546004509691;6649.501287403367;6683.465322774264;6740.966295168493;6742.954841999498;6748.358905903931;6679.298673639198;6729.899051514133;6765.830854228487;6832.897506537306;6884.139482564679;5872.677002764889;6401.231852177769;6770.221424536241;6814.284500127415;6817.5568588041615;5954.583179177589;6062.848428789315;6093.817185484442;6096.451319381277;6107.969460152671;6169.691515424301;6209.96895015522;6215.658138802229;6222.688865556614;6223.190985171898 23:13:01 INFO - 2015-12-17 23:13:01,843 DEBUG : BROWSER_OUTPUT: |4;prototype.html;327.8016799836099;331.9030603854262;336.5843183668168;337.1033052081463;343.8762045663561;5907.970460147704;5970.701464926752;6003.099535069742;6023.939760602387;6070.6661133637745;5781.4507621775865;5896.380880007602;5897.380775018615;5941.0494320908665;5964.970175149129;4583.3125031245245;4584.724916505003;4589.059242855224;4589.128065667529;4593.701409408378;4372.409724687158;4464.843730469434;4467.106578684276;4579.839705610304;4597.977010114945;4547.067851090518;4548.613367863735;4552.954470455303;4558.977205113986;4569.474510431293;4554.066416384666;4555.430571178586;4555.476120246181;4564.7032942858605;4565.269556870918;4010.859619913318;4012.1574469361467;4019.33680942647;4023.376376661622;4023.396490526415;5542.667439953616;5638.323401191842;5659.349174844904;5682.090865461506;5691.601587888849;5290.153575427951;5292.550133238679;5297.178937264692;5298.814541491068;5299.682019078868;6086.330503644595;6336.3663633636725;6347.650879201642;6351.428371446592;6355.586886852339;4296.37702533131;4307.784610769449;4386.451693538308;4405.713628614129;4411.250087485135;6505.121808555832;6550.70521826519;6560.523882126531;6572.737090516373;6573.57271777333;4492.168948744493;4496.168208881368;4497.775111244425;4502.16709908668;4506.369108324771;4468.240399132091;4554.840580579664;4555.385023021916;4557.612602928788;4575.130725162208;5274.235235890775;5281.260623512634;5281.309980806182;5285.286486324374;5289.9471005290225;6371.649559274192;6378.77674281398;6379.617222966637;6381.393767592164;6386.457151142112;1589.8092228932603;1603.2464741571443;1604.5747876812654;1605.494269305165;1606.1086097216157;1061.1139698351808;1072.790805792863;1076.39721755817;1076.4348716923678;1098.3464838421128;6069.635821850703;6072.483838873745;6082.452579267887;6088.969555152196;6096.512279017668;6488.253850807123;6521.347865213441;6546.214454265519;6575.671216439255;6595.109660195908;5947.524198064145;6089.54328425361;6093.055576385667;6097.2683278006925;6097.69511524422;3546.982265088658;3569.982150089285;3571.8035508047305;3572.1783989682517;3575;6656.400923916871;6671.132752742113;6677.165354330708;6682.498812589075;6692.498062645321;6577.736890524326;6725.562838415487;6728.629925354055;6738.427233685094;6741.52809303344;6654.999999999904;6656.400923916871;6656.667166641649;6664.900026499607;6667.433268172163;6375.9362406377195;6536.346365363615;6550;6558.1802274715665;6558.311377305315;6424.743010279723;6530.967345163243;6542.803715888531;6579.309172536815;6582.243042050225;6712.496562757715;6714.832129196614;6723.831904202434;6728.293529179366;6728.663566821541;4369.69412141147;4460.531644177315;4460.665450091191;4461.531539188469;4467.039586488921;6616.206055273398;6619.404253617197;6621.238557565749;6625.734970601122;6627.436667883284;6434.710438030206;6436.356364363526;6437.937740272802;6441.903371449338;6443.259025212161;6215.844603884939;6396.680165991775;6413.390727880844;6424.357564243538;6430.620670351999;6279.183706118175;6292.433680968735;6318.336574659595;6320.6839658016;6327.651979141191;6445.871082578416;6452.645104519109;6466.321036291121;6466.708998095003;6479.254885688018;6126.540509461897;6154.1999540059505;6263.123162757127;6269.843253918689;6313.43179113882 23:13:01 INFO - 2015-12-17 23:13:01,844 DEBUG : BROWSER_OUTPUT: |5;yui.html;831.2311112221194;835.9582020898954;842.3135144856938;845.1675100026473;853.884725562049;13382.66543336417;13705.3832577534;13705.451781928736;13708.725825483485;13745.587632371033;13125.67185820355;15007.549773506786;15051.698966020673;15085.849141508581;15111.471098511554;831.8669012957928;840.5881118252073;840.6595328891808;841.3227351981652;841.364769598955;689.2039694153236;696.4811215644352;826.3513142183388;838.4801423117675;839.7984483723924;858.1375717404001;869.1699427047155;871;871.6731225790329;871.7602659268689;712.1276436365463;721.6139365439517;861.3798065392939;864.161763089805;864.3344624639025;626.4330780643479;631.8136149835809;633.1389310537666;635.5709895820303;635.6694518850218;13705.520306789214;13714.65713357164;13757.243351615758;13764.587062388144;13779.173249604955;12301.200421972633;12480.75038499234;12610.306433146174;12736.745265094647;13077.803832942513;10282.794344113076;10591.470426478645;10916.50875710587;10945.726356841064;11177;3684.0605645560477;3721.274351501458;3754.305453491113;3836.4245363195464;3836.808159592037;46064.7696761514;46487.30269045967;46626.30060549061;46726.532734672895;46767.532324677;10139.543720532447;10372.948135259276;10676.679699609023;10697.625583104555;10847.457627118612;17904.91047544754;17939.820601794076;17970;17971.37100201487;17972.730409043874;7467.7012919483695;7527.172011078777;7682.078150621961;7747.225277472207;8002.5598592077995;4394.274944634163;4447.466304043535;4503.527129651339;4523.231050721385;4620.861374158713;3009.6388433388133;3032.9393412131635;3033.6814634463503;3036.969630303713;3042.3763128558594;539.0539602996715;543.9238506609078;546.0416968220826;555.6027440380067;561.2199043329775;677.190757045336;679.5005670831935;710.7903168565285;722.7867779005206;740.1192580828797;8291.792705182419;8617.396782225183;8642.22220000203;8681.826363472695;8756.299496040301;609.7865746988607;661.9503537234726;724.2323137474294;731.2029887422734;758.2606958215696;3983.223271462095;4024.859129930497;4132.896677583084;4239.448871646666;4363.52001279859;50673;53396;54470.72764636151;54844.45155548473;55994.440055599734;49290.014199715806;49342.75328623406;49752.50247497479;50072.49927500751;50123;43267.567324326985;43649;43979;44081.338779918966;45098.09803803971;8774.254188394058;8856.247218986458;8859.468431894107;8870.911290887267;9090.863637045317;33256.50115248225;33670.49494257637;34149.146271343416;34285.48571771475;34481;40184.1963160741;40944.59055409408;43974;45364;45916.311255330525;11239.606613768807;11405.885941140814;11410.600628977945;11546.134039947206;11852.466639001437;11768.76462470763;11773.470193841127;11888.346140961985;12921.932272006112;13064.21614703121;11579.536818527165;11861.288322700666;11945.343006134746;12027.939860300643;12245.14284000147;11487.597934072268;11786;12053.276803391824;12067.637970860887;12330.753384932072;8143.633536490754;11668.299902005907;12003.1597788154;12238.326892021025;12452.066095043088;9960.651377201762;10532.947335263274;10603.204759642904;10625.415602141957;10884.510197040994;8310.584470776557;9796.755081123029;9937.304388692723;10102.444365559964;10230.590776368861 23:13:01 INFO - 2015-12-17 23:13:01,845 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:13:01 INFO - 2015-12-17 23:13:01,845 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:13:01 INFO - 2015-12-17 23:13:01,845 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1032 23:13:01 INFO - 2015-12-17 23:13:01,845 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:13:01 INFO - 2015-12-17 23:13:01,845 DEBUG : BROWSER_OUTPUT: __startTimestamp1450422781834__endTimestamp 23:13:01 INFO - 2015-12-17 23:13:01,845 DEBUG : BROWSER_OUTPUT: 23:13:01 INFO - 2015-12-17 23:13:01,845 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:13:01 INFO - 2015-12-17 23:13:01,845 DEBUG : BROWSER_OUTPUT: Number of tests: 6 23:13:01 INFO - 2015-12-17 23:13:01,846 DEBUG : BROWSER_OUTPUT: 23:13:01 INFO - 2015-12-17 23:13:01,846 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5265.21 Median:5468.34 stddev:579.94 (10.6%) stddev-sans-first:557.12 23:13:01 INFO - 2015-12-17 23:13:01,846 DEBUG : BROWSER_OUTPUT: Values: 3134.9 3157.2 3169.2 3205.2 3231.3 5070.2 5206.5 5257.9 5324.8 5378.7 5200.2 5208.1 5220.7 5255.0 5300.6 4779.1 4794.3 4803.4 4869.6 4880.6 4791.0 4843.5 4851.7 4871.8 4931.0 4723.9 4751.8 4788.1 4799.2 4822.6 4818.8 4823.4 4848.5 4856.9 4881.2 4746.6 4806.1 4810.9 4817.8 4874.2 5148.2 5150.0 5157.4 5173.9 5176.9 5696.6 5733.5 5753.7 5808.5 5809.0 5731.9 5808.2 5817.2 5818.8 5882.3 5396.9 5405.4 5408.5 5414.2 5415.9 5650.6 5683.0 5788.6 5816.5 5823.8 5591.0 5641.1 5664.7 5665.3 5665.7 5750.5 5756.5 5758.1 5762.0 5768.3 5617.4 5623.4 5700.5 5777.5 5795.6 5653.2 5657.0 5662.7 5678.7 5709.1 4358.9 4359.4 4376.4 4379.7 4402.2 3873.2 3920.7 3921.5 3949.3 3957.1 5228.7 5294.4 5295.5 5302.5 5303.9 5625.7 5665.0 5678.2 5678.5 5689.7 5103.4 5150.6 5205.1 5215.2 5281.3 4808.2 4891.2 4905.1 4936.9 4938.6 5699.1 5700.7 5702.1 5718.7 5792.6 5575.8 5590.3 5613.8 5656.1 5683.3 5686.6 5704.9 5710.6 5712.6 5801.1 5579.1 5624.6 5633.8 5640.0 5642.9 5666.8 5719.3 5734.4 5744.7 5751.0 5392.2 5492.5 5500.0 5579.9 5601.8 5447.6 5494.8 5495.9 5501.1 5538.8 5430.2 5439.4 5442.1 5444.1 5467.2 5513.3 5523.9 5579.5 5582.9 5588.4 5468.3 5532.3 5532.6 5536.6 5578.8 23:13:01 INFO - 2015-12-17 23:13:01,846 DEBUG : BROWSER_OUTPUT: 23:13:01 INFO - 2015-12-17 23:13:01,846 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:45341.96 Median:329426.50 stddev:73793.60 (22.4%) stddev-sans-first:73924.04 23:13:01 INFO - 2015-12-17 23:13:01,847 DEBUG : BROWSER_OUTPUT: Values: 567.8 601.5 602.5 611.3 618.6 29911.7 30864.5 38623.6 38991.4 39022.0 43666.3 43917.0 43957.3 44178.3 44259.0 8750.4 8952.8 8960.2 8963.1 8963.1 7810.2 7971.2 10580.9 10900.9 10903.1 10529.5 10599.7 10652.6 10657.3 10671.4 7878.2 10519.4 10590.6 10615.4 10627.8 7762.7 10649.6 10901.8 10920.2 10927.6 39192.8 39680.0 39743.8 39781.4 39796.4 3353.4 3549.9 3862.3 3996.5 4029.2 30166.7 30373.4 30528.5 30646.5 31281.0 3924.6 3925.2 4067.5 4081.1 4082.4 267881.0 268157.0 268221.0 268261.0 268749.0 55513.3 56955.1 63794.7 65584.3 65752.7 59052.0 59282.7 59420.7 59600.4 59726.0 13903.1 14167.1 14230.3 14260.1 14272.6 9813.5 10004.2 10457.8 10694.6 10712.9 19359.2 19449.3 19516.3 19530.9 19579.1 7955.6 8022.5 8102.8 8137.7 8177.5 959.2 988.1 1037.8 1052.5 1076.0 28483.0 28853.6 29161.3 29185.7 29667.4 1020.7 1033.5 1040.8 1097.8 1125.5 13885.7 14495.4 14496.2 14716.3 14755.3 323577.0 328837.0 328880.0 329973.0 330505.0 52023.2 52141.7 52347.5 52435.0 52436.5 1337.6 1362.1 1374.8 1381.0 1384.3 27360.3 28278.3 28294.4 29922.4 31107.7 47847.5 48296.5 48399.3 48460.0 48476.5 242323.0 243418.0 245331.0 246410.0 246516.0 28821.3 29096.1 31440.2 32614.3 33169.0 38028.2 38461.0 38747.0 39103.2 39588.2 34957.7 35199.8 35480.5 35482.6 36704.8 35415.0 36031.1 36201.6 36227.6 36310.5 31760.4 31885.5 36466.3 37098.3 37266.6 28814.4 32428.2 34120.3 34171.0 34469.5 23407.8 24689.1 24734.6 25288.2 25291.5 23:13:01 INFO - 2015-12-17 23:13:01,847 DEBUG : BROWSER_OUTPUT: 23:13:01 INFO - 2015-12-17 23:13:01,847 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25837.50 Median:17294.69 stddev:74026.81 (428.0%) stddev-sans-first:74209.74 23:13:01 INFO - 2015-12-17 23:13:01,848 DEBUG : BROWSER_OUTPUT: Values: 352.7 353.5 356.2 357.7 359.2 14732.8 14981.0 15758.0 16345.8 17340.4 13557.4 14305.6 16066.9 16455.1 16506.7 5376.2 5456.8 5498.5 5500.3 5502.5 3724.6 3825.5 5114.2 5291.2 5425.5 5299.5 5489.7 5506.2 5506.3 5510.4 5055.5 5222.5 5474.4 5494.0 5494.1 5000.4 5020.4 5028.7 5029.8 5034.5 11866.4 12042.3 18509.2 19675.0 20169.6 1745.5 1860.3 1957.8 1996.8 2148.6 9530.4 9663.8 9672.5 9749.5 9896.6 1819.1 1832.1 1869.7 1872.3 1877.5 57758.4 60472.7 60503.7 60925.4 61305.4 9936.7 10188.5 10325.9 10349.5 10412.7 13504.6 13570.3 13574.5 13622.0 13630.0 7166.8 7198.7 7246.3 7273.4 7354.2 6750.9 6860.6 6864.2 6870.8 6972.4 4396.4 4458.8 4462.5 4491.3 4501.2 1687.6 1713.3 1784.4 1794.4 1801.8 894.0 906.7 975.0 998.4 1058.7 15385.4 16319.9 16972.5 17078.6 17261.2 865.5 921.6 922.7 925.1 937.3 9365.6 9650.4 9950.6 10068.9 10177.0 415240.0 417566.0 420264.0 423342.0 562481.0 77330.7 79362.6 81588.2 81876.0 83215.0 1182.3 1182.3 1207.9 1225.6 1236.5 10386.0 15442.2 15584.2 15704.0 15844.2 34236.7 36117.3 36221.0 36566.6 37147.0 25667.6 36625.0 44359.7 46649.3 53504.7 13759.4 14055.7 14220.3 14235.5 14947.1 10734.9 11203.4 11696.1 11745.5 17160.4 9829.3 9882.4 10016.5 10387.9 10396.1 9855.6 10103.4 10604.7 10612.6 10691.0 10021.4 10021.6 10025.5 10482.9 10555.3 14753.9 15018.3 15055.7 15192.4 15270.9 15012.7 15595.8 15923.8 15974.8 16521.1 23:13:01 INFO - 2015-12-17 23:13:01,848 DEBUG : BROWSER_OUTPUT: 23:13:01 INFO - 2015-12-17 23:13:01,848 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5171.42 Median:6189.83 stddev:2642.91 (42.7%) stddev-sans-first:2632.50 23:13:01 INFO - 2015-12-17 23:13:01,848 DEBUG : BROWSER_OUTPUT: Values: 1089.4 1453.7 1520.2 1628.9 1747.8 6725.8 7354.7 7527.1 7533.5 7553.8 7438.3 7448.7 7518.3 7525.2 7528.0 1936.9 1971.3 2173.7 2195.6 2207.7 2206.6 2237.7 2238.5 2239.2 2240.9 2150.5 2183.7 2204.1 2206.8 2209.1 1921.7 1953.0 2201.5 2210.2 2234.6 2153.8 2174.8 2176.9 2183.6 2184.5 7487.7 7545.6 7566.4 7567.3 7573.8 4474.3 4498.9 4515.1 4530.2 4562.2 3005.3 3029.6 3054.3 3054.6 3115.6 1007.9 1016.5 1032.7 1060.2 1066.0 9804.7 9828.3 9835.7 9836.6 9838.0 3991.7 4019.2 4078.4 4164.0 4174.8 8488.3 8502.7 8531.1 8545.7 8556.0 4563.4 4585.3 4590.9 4593.6 4598.8 4111.2 4176.3 4177.2 4192.6 4200.5 3475.0 3501.6 3513.0 3517.5 3549.1 1088.5 1111.4 1115.6 1121.9 1129.9 1314.7 1315.4 1337.7 1349.3 1355.6 6273.0 6541.8 7134.3 7158.4 7160.7 599.8 606.6 612.6 628.0 631.6 5514.8 5552.9 5571.8 5587.9 5610.2 8710.7 8815.3 8829.2 8931.2 8943.1 8714.9 8722.9 8734.0 8798.8 8826.9 6828.4 7026.1 7036.7 7070.5 7098.0 6872.1 6892.2 6905.7 6915.3 6916.9 7686.1 7914.6 7919.0 8016.0 8066.8 7456.6 7581.4 7581.7 7722.6 7722.8 6128.9 6349.5 6354.8 6357.8 6747.4 6927.2 6976.3 6980.7 6981.4 6984.5 6649.5 6683.5 6741.0 6743.0 6748.4 6679.3 6729.9 6765.8 6832.9 6884.1 5872.7 6401.2 6770.2 6814.3 6817.6 5954.6 6062.8 6093.8 6096.5 6108.0 6169.7 6210.0 6215.7 6222.7 6223.2 23:13:01 INFO - 2015-12-17 23:13:01,848 DEBUG : BROWSER_OUTPUT: 23:13:01 INFO - 2015-12-17 23:13:01,848 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5303.25 Median:6070.15 stddev:1599.00 (26.3%) stddev-sans-first:1559.27 23:13:01 INFO - 2015-12-17 23:13:01,849 DEBUG : BROWSER_OUTPUT: Values: 327.8 331.9 336.6 337.1 343.9 5908.0 5970.7 6003.1 6023.9 6070.7 5781.5 5896.4 5897.4 5941.0 5965.0 4583.3 4584.7 4589.1 4589.1 4593.7 4372.4 4464.8 4467.1 4579.8 4598.0 4547.1 4548.6 4553.0 4559.0 4569.5 4554.1 4555.4 4555.5 4564.7 4565.3 4010.9 4012.2 4019.3 4023.4 4023.4 5542.7 5638.3 5659.3 5682.1 5691.6 5290.2 5292.6 5297.2 5298.8 5299.7 6086.3 6336.4 6347.7 6351.4 6355.6 4296.4 4307.8 4386.5 4405.7 4411.3 6505.1 6550.7 6560.5 6572.7 6573.6 4492.2 4496.2 4497.8 4502.2 4506.4 4468.2 4554.8 4555.4 4557.6 4575.1 5274.2 5281.3 5281.3 5285.3 5289.9 6371.6 6378.8 6379.6 6381.4 6386.5 1589.8 1603.2 1604.6 1605.5 1606.1 1061.1 1072.8 1076.4 1076.4 1098.3 6069.6 6072.5 6082.5 6089.0 6096.5 6488.3 6521.3 6546.2 6575.7 6595.1 5947.5 6089.5 6093.1 6097.3 6097.7 3547.0 3570.0 3571.8 3572.2 3575.0 6656.4 6671.1 6677.2 6682.5 6692.5 6577.7 6725.6 6728.6 6738.4 6741.5 6655.0 6656.4 6656.7 6664.9 6667.4 6375.9 6536.3 6550.0 6558.2 6558.3 6424.7 6531.0 6542.8 6579.3 6582.2 6712.5 6714.8 6723.8 6728.3 6728.7 4369.7 4460.5 4460.7 4461.5 4467.0 6616.2 6619.4 6621.2 6625.7 6627.4 6434.7 6436.4 6437.9 6441.9 6443.3 6215.8 6396.7 6413.4 6424.4 6430.6 6279.2 6292.4 6318.3 6320.7 6327.7 6445.9 6452.6 6466.3 6466.7 6479.3 6126.5 6154.2 6263.1 6269.8 6313.4 23:13:01 INFO - 2015-12-17 23:13:01,849 DEBUG : BROWSER_OUTPUT: 23:13:01 INFO - 2015-12-17 23:13:01,849 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:13662.87 Median:43976.50 stddev:15204.07 (34.6%) stddev-sans-first:15216.19 23:13:01 INFO - 2015-12-17 23:13:01,849 DEBUG : BROWSER_OUTPUT: Values: 831.2 836.0 842.3 845.2 853.9 13382.7 13705.4 13705.5 13708.7 13745.6 13125.7 15007.5 15051.7 15085.8 15111.5 831.9 840.6 840.7 841.3 841.4 689.2 696.5 826.4 838.5 839.8 858.1 869.2 871.0 871.7 871.8 712.1 721.6 861.4 864.2 864.3 626.4 631.8 633.1 635.6 635.7 13705.5 13714.7 13757.2 13764.6 13779.2 12301.2 12480.8 12610.3 12736.7 13077.8 10282.8 10591.5 10916.5 10945.7 11177.0 3684.1 3721.3 3754.3 3836.4 3836.8 46064.8 46487.3 46626.3 46726.5 46767.5 10139.5 10372.9 10676.7 10697.6 10847.5 17904.9 17939.8 17970.0 17971.4 17972.7 7467.7 7527.2 7682.1 7747.2 8002.6 4394.3 4447.5 4503.5 4523.2 4620.9 3009.6 3032.9 3033.7 3037.0 3042.4 539.1 543.9 546.0 555.6 561.2 677.2 679.5 710.8 722.8 740.1 8291.8 8617.4 8642.2 8681.8 8756.3 609.8 662.0 724.2 731.2 758.3 3983.2 4024.9 4132.9 4239.4 4363.5 50673.0 53396.0 54470.7 54844.5 55994.4 49290.0 49342.8 49752.5 50072.5 50123.0 43267.6 43649.0 43979.0 44081.3 45098.1 8774.3 8856.2 8859.5 8870.9 9090.9 33256.5 33670.5 34149.1 34285.5 34481.0 40184.2 40944.6 43974.0 45364.0 45916.3 11239.6 11405.9 11410.6 11546.1 11852.5 11768.8 11773.5 11888.3 12921.9 13064.2 11579.5 11861.3 11945.3 12027.9 12245.1 11487.6 11786.0 12053.3 12067.6 12330.8 8143.6 11668.3 12003.2 12238.3 12452.1 9960.7 10532.9 10603.2 10625.4 10884.5 8310.6 9796.8 9937.3 10102.4 10230.6 23:13:01 INFO - 2015-12-17 23:13:01,849 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:13:01 INFO - 2015-12-17 23:13:01,850 DEBUG : BROWSER_OUTPUT: 23:13:02 INFO - 2015-12-17 23:13:02,495 INFO : Browser exited with error code: 0 23:13:02 INFO - 2015-12-17 23:13:02,511 INFO : Completed test dromaeo_css (00:18:32) 23:13:02 INFO - 2015-12-17 23:13:02,511 INFO : Starting test kraken 23:13:02 INFO - 2015-12-17 23:13:02,511 DEBUG : operating with platform_type : linux_ 23:13:02 INFO - 2015-12-17 23:13:02,511 INFO : Initialising browser for kraken test... 23:13:02 INFO - 2015-12-17 23:13:02,518 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzcEm0o/profile http://localhost:56913/getInfo.html 23:13:06 INFO - 2015-12-17 23:13:06,112 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:13:06 INFO - 2015-12-17 23:13:06,112 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:13:06 INFO - 2015-12-17 23:13:06,112 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:13:06 INFO - 2015-12-17 23:13:06,112 DEBUG : BROWSER_OUTPUT: __metrics 23:13:06 INFO - 2015-12-17 23:13:06,229 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] 23:13:06 INFO - 2015-12-17 23:13:06,273 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] 23:13:07 INFO - 2015-12-17 23:13:07,288 INFO : Browser initialized. 23:13:07 INFO - 2015-12-17 23:13:07,288 INFO : Running cycle 1/1 for kraken test... 23:13:07 INFO - 2015-12-17 23:13:07,289 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpzcEm0o/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:13:19 INFO - 2015-12-17 23:13:19,088 DEBUG : BROWSER_OUTPUT: RSS: Main: 150110208 23:13:19 INFO - 2015-12-17 23:13:19,088 DEBUG : BROWSER_OUTPUT: 23:13:21 INFO - 2015-12-17 23:13:21,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56913/tests/kraken/driver.html?testName=audio-beat-detection) 23:13:22 INFO - 2015-12-17 23:13:22,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 185745408 23:13:22 INFO - 2015-12-17 23:13:22,152 DEBUG : BROWSER_OUTPUT: 23:13:24 INFO - 2015-12-17 23:13:24,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56913/tests/kraken/driver.html?testName=audio-dft) 23:13:25 INFO - 2015-12-17 23:13:25,338 DEBUG : BROWSER_OUTPUT: RSS: Main: 176361472 23:13:25 INFO - 2015-12-17 23:13:25,339 DEBUG : BROWSER_OUTPUT: 23:13:28 INFO - 2015-12-17 23:13:28,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56913/tests/kraken/driver.html?testName=audio-fft) 23:13:28 INFO - 2015-12-17 23:13:28,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 160157696 23:13:28 INFO - 2015-12-17 23:13:28,822 DEBUG : BROWSER_OUTPUT: 23:13:30 INFO - 2015-12-17 23:13:30,813 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56913/tests/kraken/driver.html?testName=audio-oscillator) 23:13:31 INFO - 2015-12-17 23:13:31,382 DEBUG : BROWSER_OUTPUT: RSS: Main: 163229696 23:13:31 INFO - 2015-12-17 23:13:31,382 DEBUG : BROWSER_OUTPUT: 23:13:33 INFO - 2015-12-17 23:13:33,596 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56913/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:13:34 INFO - 2015-12-17 23:13:34,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 163983360 23:13:34 INFO - 2015-12-17 23:13:34,149 DEBUG : BROWSER_OUTPUT: 23:13:37 INFO - 2015-12-17 23:13:37,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56913/tests/kraken/driver.html?testName=imaging-darkroom) 23:13:37 INFO - 2015-12-17 23:13:37,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 165687296 23:13:37 INFO - 2015-12-17 23:13:37,631 DEBUG : BROWSER_OUTPUT: 23:13:40 INFO - 2015-12-17 23:13:40,993 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56913/tests/kraken/driver.html?testName=imaging-desaturate) 23:13:41 INFO - 2015-12-17 23:13:41,566 DEBUG : BROWSER_OUTPUT: RSS: Main: 166219776 23:13:41 INFO - 2015-12-17 23:13:41,566 DEBUG : BROWSER_OUTPUT: 23:13:44 INFO - 2015-12-17 23:13:44,303 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56913/tests/kraken/driver.html?testName=json-parse-financial) 23:13:44 INFO - 2015-12-17 23:13:44,875 DEBUG : BROWSER_OUTPUT: RSS: Main: 165498880 23:13:44 INFO - 2015-12-17 23:13:44,875 DEBUG : BROWSER_OUTPUT: 23:13:46 INFO - 2015-12-17 23:13:46,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56913/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:13:46 INFO - 2015-12-17 23:13:46,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 174706688 23:13:46 INFO - 2015-12-17 23:13:46,990 DEBUG : BROWSER_OUTPUT: 23:13:48 INFO - 2015-12-17 23:13:48,771 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56913/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:13:49 INFO - 2015-12-17 23:13:49,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 173031424 23:13:49 INFO - 2015-12-17 23:13:49,373 DEBUG : BROWSER_OUTPUT: 23:13:51 INFO - 2015-12-17 23:13:51,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56913/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:13:51 INFO - 2015-12-17 23:13:51,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 184561664 23:13:51 INFO - 2015-12-17 23:13:51,991 DEBUG : BROWSER_OUTPUT: 23:13:54 INFO - 2015-12-17 23:13:54,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:13:54 INFO - 2015-12-17 23:13:54,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 190967808 23:13:54 INFO - 2015-12-17 23:13:54,956 DEBUG : BROWSER_OUTPUT: 23:13:57 INFO - 2015-12-17 23:13:57,541 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:13:58 INFO - 2015-12-17 23:13:58,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 189169664 23:13:58 INFO - 2015-12-17 23:13:58,111 DEBUG : BROWSER_OUTPUT: 23:13:59 INFO - 2015-12-17 23:13:59,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56913/tests/kraken/driver.html?testName=ai-astar) 23:14:00 INFO - 2015-12-17 23:14:00,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 247394304 23:14:00 INFO - 2015-12-17 23:14:00,029 DEBUG : BROWSER_OUTPUT: 23:14:00 INFO - 2015-12-17 23:14:00,030 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:14:00 INFO - 2015-12-17 23:14:00,031 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:14:00 INFO - 2015-12-17 23:14:00,031 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:14:00 INFO - 2015-12-17 23:14:00,031 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:14:00 INFO - 2015-12-17 23:14:00,031 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;107;112;112;111;101;110;111;110 23:14:00 INFO - 2015-12-17 23:14:00,032 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;122;157;163;125;149;164;126;164;124 23:14:00 INFO - 2015-12-17 23:14:00,032 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;162;162;160;161;160;160;164;162;161 23:14:00 INFO - 2015-12-17 23:14:00,032 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;73;85;94;70;73;70;99;91;71 23:14:00 INFO - 2015-12-17 23:14:00,032 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;139;92;94;94;147;93;93;141 23:14:00 INFO - 2015-12-17 23:14:00,032 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;109;110;110;111;110;109;109 23:14:00 INFO - 2015-12-17 23:14:00,033 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;146;145;146;144;146;145;145;147;146 23:14:00 INFO - 2015-12-17 23:14:00,033 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;95;95;95;95;96;95 23:14:00 INFO - 2015-12-17 23:14:00,033 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;57;58;56;57;57;57;67;55;58 23:14:00 INFO - 2015-12-17 23:14:00,033 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;67;67;68;72;68;67;67;68 23:14:00 INFO - 2015-12-17 23:14:00,033 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;83;83;83;83;82;84;83;89;83 23:14:00 INFO - 2015-12-17 23:14:00,033 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;122;121;113;116;127;124;122;114;124 23:14:00 INFO - 2015-12-17 23:14:00,033 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;154;152;152;156;153;152;153;159;154 23:14:00 INFO - 2015-12-17 23:14:00,033 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;67;67;67;69;68;66;70;69 23:14:00 INFO - 2015-12-17 23:14:00,034 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:14:00 INFO - 2015-12-17 23:14:00,034 DEBUG : BROWSER_OUTPUT: __start_cc_report 23:14:00 INFO - 2015-12-17 23:14:00,034 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,927 23:14:00 INFO - 2015-12-17 23:14:00,034 DEBUG : BROWSER_OUTPUT: __end_cc_report 23:14:00 INFO - 2015-12-17 23:14:00,034 DEBUG : BROWSER_OUTPUT: __startTimestamp1450422840029__endTimestamp 23:14:00 INFO - 2015-12-17 23:14:00,034 DEBUG : BROWSER_OUTPUT: 23:14:00 INFO - 2015-12-17 23:14:00,038 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:14:00 INFO - 2015-12-17 23:14:00,038 DEBUG : BROWSER_OUTPUT: Number of tests: 14 23:14:00 INFO - 2015-12-17 23:14:00,038 DEBUG : BROWSER_OUTPUT: 23:14:00 INFO - 2015-12-17 23:14:00,038 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.31 (3.0%) stddev-sans-first:3.50 23:14:00 INFO - 2015-12-17 23:14:00,039 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 107.0 112.0 112.0 111.0 101.0 110.0 111.0 110.0 23:14:00 INFO - 2015-12-17 23:14:00,039 DEBUG : BROWSER_OUTPUT: 23:14:00 INFO - 2015-12-17 23:14:00,039 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.00 Median:153.00 stddev:18.04 (11.8%) stddev-sans-first:19.12 23:14:00 INFO - 2015-12-17 23:14:00,039 DEBUG : BROWSER_OUTPUT: Values: 146.0 122.0 157.0 163.0 125.0 149.0 164.0 126.0 164.0 124.0 23:14:00 INFO - 2015-12-17 23:14:00,040 DEBUG : BROWSER_OUTPUT: 23:14:00 INFO - 2015-12-17 23:14:00,040 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.32 (0.8%) stddev-sans-first:1.32 23:14:00 INFO - 2015-12-17 23:14:00,040 DEBUG : BROWSER_OUTPUT: Values: 160.0 162.0 162.0 160.0 161.0 160.0 160.0 164.0 162.0 161.0 23:14:00 INFO - 2015-12-17 23:14:00,040 DEBUG : BROWSER_OUTPUT: 23:14:00 INFO - 2015-12-17 23:14:00,041 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.60 Median:79.00 stddev:11.45 (14.5%) stddev-sans-first:11.61 23:14:00 INFO - 2015-12-17 23:14:00,041 DEBUG : BROWSER_OUTPUT: Values: 70.0 73.0 85.0 94.0 70.0 73.0 70.0 99.0 91.0 71.0 23:14:00 INFO - 2015-12-17 23:14:00,041 DEBUG : BROWSER_OUTPUT: 23:14:00 INFO - 2015-12-17 23:14:00,041 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.90 Median:93.00 stddev:23.85 (25.6%) stddev-sans-first:24.68 23:14:00 INFO - 2015-12-17 23:14:00,042 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 139.0 92.0 94.0 94.0 147.0 93.0 93.0 141.0 23:14:00 INFO - 2015-12-17 23:14:00,042 DEBUG : BROWSER_OUTPUT: 23:14:00 INFO - 2015-12-17 23:14:00,042 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 23:14:00 INFO - 2015-12-17 23:14:00,042 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 109.0 110.0 110.0 111.0 110.0 109.0 109.0 23:14:00 INFO - 2015-12-17 23:14:00,042 DEBUG : BROWSER_OUTPUT: 23:14:00 INFO - 2015-12-17 23:14:00,043 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 23:14:00 INFO - 2015-12-17 23:14:00,043 DEBUG : BROWSER_OUTPUT: Values: 145.0 146.0 145.0 146.0 144.0 146.0 145.0 145.0 147.0 146.0 23:14:00 INFO - 2015-12-17 23:14:00,043 DEBUG : BROWSER_OUTPUT: 23:14:00 INFO - 2015-12-17 23:14:00,043 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 23:14:00 INFO - 2015-12-17 23:14:00,043 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 23:14:00 INFO - 2015-12-17 23:14:00,043 DEBUG : BROWSER_OUTPUT: 23:14:00 INFO - 2015-12-17 23:14:00,043 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.00 Median:57.50 stddev:3.30 (5.7%) stddev-sans-first:3.50 23:14:00 INFO - 2015-12-17 23:14:00,043 DEBUG : BROWSER_OUTPUT: Values: 58.0 57.0 58.0 56.0 57.0 57.0 57.0 67.0 55.0 58.0 23:14:00 INFO - 2015-12-17 23:14:00,043 DEBUG : BROWSER_OUTPUT: 23:14:00 INFO - 2015-12-17 23:14:00,043 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:67.50 stddev:1.55 (2.3%) stddev-sans-first:1.62 23:14:00 INFO - 2015-12-17 23:14:00,043 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 67.0 67.0 68.0 72.0 68.0 67.0 67.0 68.0 23:14:00 INFO - 2015-12-17 23:14:00,044 DEBUG : BROWSER_OUTPUT: 23:14:00 INFO - 2015-12-17 23:14:00,044 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:1.96 (2.4%) stddev-sans-first:2.06 23:14:00 INFO - 2015-12-17 23:14:00,044 DEBUG : BROWSER_OUTPUT: Values: 83.0 83.0 83.0 83.0 83.0 82.0 84.0 83.0 89.0 83.0 23:14:00 INFO - 2015-12-17 23:14:00,044 DEBUG : BROWSER_OUTPUT: 23:14:00 INFO - 2015-12-17 23:14:00,044 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.30 Median:123.00 stddev:5.52 (4.5%) stddev-sans-first:4.87 23:14:00 INFO - 2015-12-17 23:14:00,044 DEBUG : BROWSER_OUTPUT: Values: 130.0 122.0 121.0 113.0 116.0 127.0 124.0 122.0 114.0 124.0 23:14:00 INFO - 2015-12-17 23:14:00,044 DEBUG : BROWSER_OUTPUT: 23:14:00 INFO - 2015-12-17 23:14:00,044 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.80 Median:153.50 stddev:4.08 (2.7%) stddev-sans-first:2.32 23:14:00 INFO - 2015-12-17 23:14:00,045 DEBUG : BROWSER_OUTPUT: Values: 143.0 154.0 152.0 152.0 156.0 153.0 152.0 153.0 159.0 154.0 23:14:00 INFO - 2015-12-17 23:14:00,045 DEBUG : BROWSER_OUTPUT: 23:14:00 INFO - 2015-12-17 23:14:00,045 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 23:14:00 INFO - 2015-12-17 23:14:00,045 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 67.0 67.0 69.0 68.0 66.0 70.0 69.0 23:14:00 INFO - 2015-12-17 23:14:00,045 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:14:00 INFO - 2015-12-17 23:14:00,045 DEBUG : BROWSER_OUTPUT: 23:14:00 INFO - 2015-12-17 23:14:00,819 INFO : Browser exited with error code: 0 23:14:00 INFO - 2015-12-17 23:14:00,872 INFO : Completed test kraken (00:00:58) 23:14:00 INFO - 2015-12-17 23:14:00,872 INFO : Starting test v8_7 23:14:00 INFO - 2015-12-17 23:14:00,872 DEBUG : operating with platform_type : linux_ 23:14:00 INFO - 2015-12-17 23:14:00,872 INFO : Initialising browser for v8_7 test... 23:14:00 INFO - 2015-12-17 23:14:00,879 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyTbmSJ/profile http://localhost:56913/getInfo.html 23:14:04 INFO - 2015-12-17 23:14:04,533 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 23:14:04 INFO - 2015-12-17 23:14:04,534 DEBUG : BROWSER_OUTPUT: colorDepth:24 23:14:04 INFO - 2015-12-17 23:14:04,534 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 23:14:04 INFO - 2015-12-17 23:14:04,534 DEBUG : BROWSER_OUTPUT: __metrics 23:14:04 INFO - 2015-12-17 23:14:04,631 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] 23:14:04 INFO - 2015-12-17 23:14:04,679 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] 23:14:05 INFO - 2015-12-17 23:14:05,749 INFO : Browser initialized. 23:14:05 INFO - 2015-12-17 23:14:05,750 INFO : Running cycle 1/1 for v8_7 test... 23:14:05 INFO - 2015-12-17 23:14:05,750 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyTbmSJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 23:14:17 INFO - 2015-12-17 23:14:17,565 DEBUG : BROWSER_OUTPUT: RSS: Main: 149262336 23:14:17 INFO - 2015-12-17 23:14:17,565 DEBUG : BROWSER_OUTPUT: 23:14:38 INFO - 2015-12-17 23:14:38,974 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56913/tests/v8_7/run.html (next: http://localhost:56913/tests/v8_7/run.html) 23:14:39 INFO - 2015-12-17 23:14:39,232 DEBUG : BROWSER_OUTPUT: RSS: Main: 577863680 23:14:39 INFO - 2015-12-17 23:14:39,232 DEBUG : BROWSER_OUTPUT: 23:14:39 INFO - 2015-12-17 23:14:39,232 DEBUG : BROWSER_OUTPUT: __start_tp_report 23:14:39 INFO - 2015-12-17 23:14:39,233 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 23:14:39 INFO - 2015-12-17 23:14:39,233 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 23:14:39 INFO - 2015-12-17 23:14:39,233 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 23:14:39 INFO - 2015-12-17 23:14:39,233 DEBUG : BROWSER_OUTPUT: |0;Richards;165.01650165016503 23:14:39 INFO - 2015-12-17 23:14:39,233 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;189.000189000189 23:14:39 INFO - 2015-12-17 23:14:39,233 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.01785714285717 23:14:39 INFO - 2015-12-17 23:14:39,233 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 23:14:39 INFO - 2015-12-17 23:14:39,233 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2032.520325203252 23:14:39 INFO - 2015-12-17 23:14:39,234 DEBUG : BROWSER_OUTPUT: |5;Earley;763.539282990084 23:14:39 INFO - 2015-12-17 23:14:39,234 DEBUG : BROWSER_OUTPUT: |6;Boyer;12219.512195121952 23:14:39 INFO - 2015-12-17 23:14:39,234 DEBUG : BROWSER_OUTPUT: |7;RegExp;24926.829268292684 23:14:39 INFO - 2015-12-17 23:14:39,234 DEBUG : BROWSER_OUTPUT: |8;Splay;614.0672782874618 23:14:39 INFO - 2015-12-17 23:14:39,234 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 23:14:39 INFO - 2015-12-17 23:14:39,234 DEBUG : BROWSER_OUTPUT: __end_tp_report 23:14:39 INFO - 2015-12-17 23:14:39,234 DEBUG : BROWSER_OUTPUT: __startTimestamp1450422879226__endTimestamp 23:14:39 INFO - 2015-12-17 23:14:39,235 DEBUG : BROWSER_OUTPUT: 23:14:39 INFO - 2015-12-17 23:14:39,235 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 23:14:39 INFO - 2015-12-17 23:14:39,235 DEBUG : BROWSER_OUTPUT: Number of tests: 10 23:14:39 INFO - 2015-12-17 23:14:39,235 DEBUG : BROWSER_OUTPUT: 23:14:39 INFO - 2015-12-17 23:14:39,235 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.02 Median:165.02 stddev:0.00 (0.0%) 23:14:39 INFO - 2015-12-17 23:14:39,235 DEBUG : BROWSER_OUTPUT: Values: 165.0 23:14:39 INFO - 2015-12-17 23:14:39,235 DEBUG : BROWSER_OUTPUT: 23:14:39 INFO - 2015-12-17 23:14:39,236 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:189.00 Median:189.00 stddev:0.00 (0.0%) 23:14:39 INFO - 2015-12-17 23:14:39,236 DEBUG : BROWSER_OUTPUT: Values: 189.0 23:14:39 INFO - 2015-12-17 23:14:39,236 DEBUG : BROWSER_OUTPUT: 23:14:39 INFO - 2015-12-17 23:14:39,236 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 23:14:39 INFO - 2015-12-17 23:14:39,236 DEBUG : BROWSER_OUTPUT: Values: 279.0 23:14:39 INFO - 2015-12-17 23:14:39,236 DEBUG : BROWSER_OUTPUT: 23:14:39 INFO - 2015-12-17 23:14:39,236 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 23:14:39 INFO - 2015-12-17 23:14:39,237 DEBUG : BROWSER_OUTPUT: Values: 5128.2 23:14:39 INFO - 2015-12-17 23:14:39,237 DEBUG : BROWSER_OUTPUT: 23:14:39 INFO - 2015-12-17 23:14:39,237 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2032.52 Median:2032.52 stddev:0.00 (0.0%) 23:14:39 INFO - 2015-12-17 23:14:39,237 DEBUG : BROWSER_OUTPUT: Values: 2032.5 23:14:39 INFO - 2015-12-17 23:14:39,237 DEBUG : BROWSER_OUTPUT: 23:14:39 INFO - 2015-12-17 23:14:39,237 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:763.54 Median:763.54 stddev:0.00 (0.0%) 23:14:39 INFO - 2015-12-17 23:14:39,237 DEBUG : BROWSER_OUTPUT: Values: 763.5 23:14:39 INFO - 2015-12-17 23:14:39,237 DEBUG : BROWSER_OUTPUT: 23:14:39 INFO - 2015-12-17 23:14:39,238 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 23:14:39 INFO - 2015-12-17 23:14:39,238 DEBUG : BROWSER_OUTPUT: Values: 12219.5 23:14:39 INFO - 2015-12-17 23:14:39,238 DEBUG : BROWSER_OUTPUT: 23:14:39 INFO - 2015-12-17 23:14:39,238 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24926.83 Median:24926.83 stddev:0.00 (0.0%) 23:14:39 INFO - 2015-12-17 23:14:39,238 DEBUG : BROWSER_OUTPUT: Values: 24926.8 23:14:39 INFO - 2015-12-17 23:14:39,238 DEBUG : BROWSER_OUTPUT: 23:14:39 INFO - 2015-12-17 23:14:39,238 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:614.07 Median:614.07 stddev:0.00 (0.0%) 23:14:39 INFO - 2015-12-17 23:14:39,239 DEBUG : BROWSER_OUTPUT: Values: 614.1 23:14:39 INFO - 2015-12-17 23:14:39,239 DEBUG : BROWSER_OUTPUT: 23:14:39 INFO - 2015-12-17 23:14:39,239 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 23:14:39 INFO - 2015-12-17 23:14:39,239 DEBUG : BROWSER_OUTPUT: Values: 4845.4 23:14:39 INFO - 2015-12-17 23:14:39,239 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 23:14:39 INFO - 2015-12-17 23:14:39,239 DEBUG : BROWSER_OUTPUT: 23:14:40 INFO - 2015-12-17 23:14:40,089 INFO : Browser exited with error code: 0 23:14:40 INFO - 2015-12-17 23:14:40,102 INFO : Completed test v8_7 (00:00:39) 23:14:40 INFO - 2015-12-17 23:14:40,212 INFO : Completed test suite (00:20:10) 23:14:40 INFO - 2015-12-17 23:14:40,212 DEBUG : Working with test: dromaeo_css 23:14:40 INFO - 2015-12-17 23:14:40,212 DEBUG : Generating results file: dromaeo_css 23:14:40 INFO - 2015-12-17 23:14:40,213 DEBUG : Working with test: kraken 23:14:40 INFO - 2015-12-17 23:14:40,213 DEBUG : Generating results file: kraken 23:14:40 INFO - 2015-12-17 23:14:40,214 INFO : javascript benchmark 23:14:40 INFO - 2015-12-17 23:14:40,214 DEBUG : Working with test: v8_7 23:14:40 INFO - 2015-12-17 23:14:40,214 DEBUG : Generating results file: v8_7 23:14:40 INFO - 2015-12-17 23:14:40,214 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:40 INFO - 2015-12-17 23:14:40,357 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 23:14:40 INFO - 2015-12-17 23:14:40,357 DEBUG : process_Request line: dromaeo_css 6907.74 graph.html#tests=[[72,201,35]] 23:14:40 INFO - 2015-12-17 23:14:40,357 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:40 INFO - 2015-12-17 23:14:40,398 DEBUG : process_Request line: kraken 1504.20 graph.html#tests=[[232,201,35]] 23:14:40 INFO - 2015-12-17 23:14:40,398 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:14:40 INFO - 2015-12-17 23:14:40,434 DEBUG : process_Request line: v8_7 19933.51 graph.html#tests=[[230,201,35]] 23:14:40 INFO - 2015-12-17 23:14:40,436 INFO : javascript benchmark 23:14:40 INFO - 2015-12-17 23:14:40,439 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3134.8589313480893, 3157.242261857155, 3169.207698075481, 3205.1987003249187, 3231.2729635831934, 5070.23946408039, 5206.45332240115, 5257.92113118303, 5324.840254792358, 5378.677279363241, 5200.245964335169, 5208.114620514512, 5220.686758794475, 5255.0, 5300.628955973083, 4779.115863565243, 4794.32879396883, 4803.423589169304, 4869.561739443449, 4880.609551235911, 4790.952090479085, 4843.467218605951, 4851.684640498374, 4871.805127794902, 4931.013797240548, 4723.929141062904, 4751.809927602892, 4788.11419887322, 4799.184138696395, 4822.565969062801, 4818.807247710088, 4823.421189457253, 4848.539388758062, 4856.878578035542, 4881.243407271879, 4746.596539294164, 4806.086843499724, 4810.903781924377, 4817.78319975602, 4874.195757699975, 5148.2020286855595, 5150.021495915764, 5157.381114266312, 5173.896522069537, 5176.870578235575, 5696.629719068289, 5733.483986441199, 5753.654780713171, 5808.535317174616, 5808.97095514524, 5731.914021289643, 5808.215890854765, 5817.243758311435, 5818.8254352369495, 5882.323532793741, 5396.865078373033, 5405.4324295949145, 5408.486193811582, 5414.187871819219, 5415.891682166334, 5650.576206784508, 5683.0, 5788.594798364074, 5816.47651711348, 5823.79616713413, 5590.972045139748, 5641.069223578145, 5664.745086471119, 5665.291838520185, 5665.745041473144, 5750.5112065474905, 5756.510696590837, 5758.107493338539, 5761.971190144106, 5768.307803063575, 5617.43825617435, 5623.381428042912, 5700.515456186271, 5777.508911742465, 5795.623284486495, 5653.2085508028085, 5657.0, 5662.68855212959, 5678.716064196857, 5709.058005429058, 4358.912821743547, 4359.411479450297, 4376.387305777193, 4379.715318504287, 4402.207602631557, 3873.1866308075055, 3920.7059470539825, 3921.5490218624655, 3949.269385163754, 3957.149212919236, 5228.738563071831, 5294.391145018295, 5295.523402893758, 5302.522772950453, 5303.920441193385, 5625.71871406428, 5664.97167514168, 5678.205051292823, 5678.488935995698, 5689.715514224272, 5103.438621751604, 5150.562202212779, 5205.063088644005, 5215.24378965048, 5281.339832520935, 4808.182608956486, 4891.217405215149, 4905.092557876804, 4936.90126197474, 4938.58022068121, 5699.059655156935, 5700.743466544015, 5702.087665973424, 5718.68547229898, 5792.623479473821, 5575.77696892136, 5590.329160500766, 5613.803516876889, 5656.095024796013, 5683.346415162309, 5686.573506987075, 5704.857378565569, 5710.628809127394, 5712.6001179917, 5801.071828507418, 5579.107342825128, 5624.606277560695, 5633.802816901389, 5639.956608027528, 5642.915356269741, 5666.801661941812, 5719.28508936383, 5734.369219385948, 5744.712764361681, 5751.0, 5392.164214546751, 5492.4507549246355, 5500.009998200202, 5579.860503487445, 5601.80393686219, 5447.64590301645, 5494.80768173112, 5495.917561236664, 5501.0648189807025, 5538.833834984957, 5430.185472179205, 5439.374471935778, 5442.102053161184, 5444.074507333842, 5467.17992301158, 5513.338399391938, 5523.861903452445, 5579.525740311957, 5582.860428489158, 5588.3573389060775, 5468.3437987440175, 5532.28080349552, 5532.612717109763, 5536.640118392292, 5578.776848925998], "unit": "score", "name": "dojo.html", "value": 5227.880408755353}, {"lowerIsBetter": false, "replicates": [567.775728587208, 601.5067644531481, 602.5059451249971, 611.3244864424811, 618.601002353482, 29911.700882991165, 30864.53703194451, 38623.613763862355, 38991.41512877302, 39022.0, 43666.34500482487, 43917.0, 43957.340639890426, 44178.33732494007, 44259.0, 8750.387472876886, 8952.776180595505, 8960.23837973773, 8963.10368963105, 8963.148500892405, 7810.218978102201, 7971.163027882076, 10580.947095264513, 10900.890991090067, 10903.127749780038, 10529.52617132227, 10599.682009539727, 10652.573897044109, 10657.253992220547, 10671.35971841692, 7878.1727918568295, 10519.368837869752, 10590.570273013122, 10615.416152111631, 10627.78744425115, 7762.650680719381, 10649.57401703931, 10901.83647245292, 10920.18098642597, 10927.617533386372, 39192.804035979636, 39680.0, 39743.8012809937, 39781.40327895084, 39796.403053954215, 3353.4299169141304, 3549.9112522186892, 3862.3347853513246, 3996.480457540501, 4029.174019326031, 30166.698333016608, 30373.392532149453, 30528.54207186894, 30646.540301895267, 31281.0, 3924.6271604197555, 3925.1560914403253, 4067.491563554556, 4081.08175660477, 4082.448869402622, 267881.0, 268157.0, 268221.0, 268261.0, 268749.0, 55513.2813710831, 56955.14567281494, 63794.68102659457, 65584.34415655877, 65752.67123664447, 59052.0, 59282.703586482654, 59420.7028964861, 59600.403995960354, 59726.0, 13903.09629874055, 14167.149971001567, 14230.288485575888, 14260.144391336553, 14272.571822845332, 9813.509324533745, 10004.249681273788, 10457.84313235302, 10694.62568810088, 10712.89287107119, 19359.225630974885, 19449.277101205844, 19516.336018136106, 19530.902345488466, 19579.09083221827, 7955.641996110189, 8022.478538894953, 8102.7569172924905, 8137.674493020213, 8177.509349439053, 959.2469911119738, 988.0909563201872, 1037.823569993103, 1052.5053224984244, 1076.0046956565145, 28483.0, 28853.56719649207, 29161.270968225963, 29185.708142918298, 29667.406651867273, 1020.6733845169623, 1033.509083185481, 1040.78143589847, 1097.8078836203792, 1125.482278152043, 13885.72706712723, 14495.420183192766, 14496.245713314436, 14716.264186790617, 14755.262236888113, 323577.0, 328837.0, 328880.0, 329973.0, 330505.0, 52023.21965170526, 52141.7392913033, 52347.47652523426, 52435.0, 52436.47563524392, 1337.6321511584392, 1362.0669841158838, 1374.752544541972, 1381.040177076922, 1384.2940100548792, 27360.315992100357, 28278.293042674097, 28294.434111317245, 29922.401551969273, 31107.68892311048, 47847.52152478431, 48296.5170348292, 48399.27401089057, 48460.0, 48476.5152348472, 242323.0, 243418.0, 245331.0, 246410.0, 246516.0, 28821.279468012628, 29096.127116186548, 31440.213994650316, 32614.34771304608, 33169.0, 38028.2394352117, 38461.038474038374, 38747.0, 39103.21793564056, 39588.20823583454, 34957.65042349544, 35199.82400087983, 35480.46779298364, 35482.645173547935, 36704.81647591745, 35415.0, 36031.099222519646, 36201.637983619825, 36227.63772362243, 36310.45534316934, 31760.36479270448, 31885.521717173797, 36466.27067458583, 37098.258034839695, 37266.62733372632, 28814.423711526073, 32428.189295267806, 34120.317593648484, 34171.0, 34469.482957756154, 23407.76592234124, 24689.135880244106, 24734.628980565667, 25288.241352759447, 25291.49417011686], "unit": "score", "name": "ext.html", "value": 18678.38746142734}, {"lowerIsBetter": false, "replicates": [352.7178257394084, 353.52980535887264, 356.16124027914253, 357.65486305714995, 359.2097385751348, 14732.779008314883, 14980.998037705876, 15758.0, 16345.75481367779, 17340.393086242, 13557.389917453713, 14305.642358941006, 16066.919665401685, 16455.09496977666, 16506.66986660266, 5376.220448035042, 5456.836294911139, 5498.45015498451, 5500.339959204901, 5502.532284755781, 3724.590295067554, 3825.5026846510054, 5114.181730923053, 5291.2327712481665, 5425.538829199503, 5299.54953828925, 5489.725513724317, 5506.174073888908, 5506.284183056197, 5510.448955104497, 5055.51972562606, 5222.529972302511, 5474.39781624021, 5493.972530137344, 5494.120940649497, 5000.449950505442, 5020.4226513951, 5028.673136246132, 5029.7736601853, 5034.496550344973, 11866.406679665983, 12042.277463352228, 18509.16708748096, 19675.016249187483, 20169.596608067757, 1745.519982004946, 1860.3302810988034, 1957.784643689193, 1996.800319968006, 2148.602508535926, 9530.428174309563, 9663.758406039835, 9672.516374181263, 9749.512524373753, 9896.55465504054, 1819.0995457248746, 1832.0748022248813, 1869.6541139889164, 1872.3259626534436, 1877.474307193988, 57758.42241577573, 60472.69763651198, 60503.697481512754, 60925.39074609242, 61305.38694613041, 9936.652217172508, 10188.490575471345, 10325.9483702581, 10349.534270957674, 10412.68761937143, 13504.594862154152, 13570.253636050113, 13574.524891628746, 13622.0, 13630.0, 7166.820829479305, 7198.676059577331, 7246.311600397954, 7273.381762550137, 7354.191038985708, 6750.8649827004165, 6860.622665753432, 6864.1762988440705, 6870.7595234166565, 6972.442204623618, 4396.362527433568, 4458.77706114693, 4462.509123996358, 4491.258942274553, 4501.2347900856275, 1687.5612340791483, 1713.3146741303578, 1784.3843873863495, 1794.425783749214, 1801.7567628370002, 893.9553022348856, 906.6600024990629, 974.9951250243703, 998.3610489286863, 1058.6929790360864, 15385.382540228655, 16319.91840040816, 16972.49082527526, 17078.573035674206, 17261.223244954006, 865.5066612031081, 921.5714692667808, 922.7139586728135, 925.1349987761464, 937.3063932689897, 9365.578548965314, 9650.420974741539, 9950.552225149886, 10068.899311006942, 10177.0, 415240.0, 417566.0, 420264.0, 423342.0, 562481.0, 77330.69196539684, 79362.60318698485, 81588.18411815805, 81876.0, 83215.0, 1182.266994463421, 1182.3497076608003, 1207.897328727068, 1225.6200577820905, 1236.5486597392066, 10386.0, 15442.22788860575, 15584.220788960733, 15704.0, 15844.207789610244, 34236.657633424344, 36117.27765444624, 36221.0, 36566.63433365632, 37147.0, 25667.614985774853, 36625.0, 44359.669209923755, 46649.30026049544, 53504.73247633737, 13759.449622015407, 14055.718885622025, 14220.288985550887, 14235.50175743844, 14947.103173809606, 10734.946325268324, 11203.43982800873, 11696.06431485462, 11745.530178792753, 17160.399386021927, 9829.262805289489, 9882.357646752938, 10016.499175041365, 10387.94806025965, 10396.116330111723, 9855.605775768889, 10103.393796371947, 10604.681859544226, 10612.575496980344, 10691.037806597444, 10021.39871607706, 10021.649242276486, 10025.5488503019, 10482.895171048192, 10555.261131721012, 14753.92623036878, 15018.324175411914, 15055.698886022437, 15192.392304307705, 15270.923645381701, 15012.699746005237, 15595.84404155944, 15923.840761592699, 15974.8402515978, 16521.091339976418], "unit": "score", "name": "jquery.html", "value": 8567.003348807912}, {"lowerIsBetter": false, "replicates": [1089.4226060188103, 1453.7165252775708, 1520.247477498638, 1628.918554072296, 1747.7727895373607, 6725.79822605322, 7354.669039893204, 7527.059117610299, 7533.472656914018, 7553.811154721135, 7438.256174382559, 7448.7392941246935, 7518.323350898418, 7525.209852965429, 7528.0, 1936.8741031832885, 1971.2903354792263, 2173.6739489076685, 2195.5938151442033, 2207.6578130389817, 2206.580749657568, 2237.7090978172814, 2238.5187184755273, 2239.2162743039967, 2240.8543444676043, 2150.4516348331153, 2183.6833659119497, 2204.1403852497538, 2206.8013878750908, 2209.149477451185, 1921.730957665928, 1952.9609407811836, 2201.4826515768864, 2210.24851550472, 2234.55308938213, 2153.752318483379, 2174.8151407130254, 2176.9346919592435, 2183.5960347335795, 2184.5084855907453, 7487.737929172453, 7545.584992825392, 7566.432517561205, 7567.281108294758, 7573.772786816405, 4474.284114541658, 4498.865034048984, 4515.074409745994, 4530.184566777979, 4562.156001139767, 3005.2637103909683, 3029.621297337833, 3054.312779624589, 3054.618172728409, 3115.5793967814284, 1007.8588997540351, 1016.4561959351711, 1032.726327523207, 1060.2207377577474, 1065.984010239847, 9804.656837010742, 9828.262880284008, 9835.655752048715, 9836.606535738561, 9837.950810245975, 3991.7405368650943, 4019.2162528307285, 4078.4494093297617, 4163.979180104141, 4174.812133454002, 8488.320934325238, 8502.74491765248, 8531.06158322584, 8545.74362769118, 8555.957220213984, 4563.361129441881, 4585.312203169551, 4590.88522786933, 4593.586577208067, 4598.793054312564, 4111.198316328347, 4176.331786914079, 4177.248095342868, 4192.580741925783, 4200.537940826506, 3474.965250347515, 3501.632328605511, 3513.0339156731593, 3517.50754894315, 3549.0594992327055, 1088.5373716170595, 1111.372074777748, 1115.642994241851, 1121.942706125817, 1129.9096372000895, 1314.677903913528, 1315.3620494060374, 1337.6588969812635, 1349.2579081505132, 1355.620426280643, 6272.968635156886, 6541.771038013647, 7134.286571342825, 7158.391536719333, 7160.713571457188, 599.7960693364278, 606.5693357715983, 612.5865041097242, 627.9937200627935, 631.5768435148461, 5514.834554963358, 5552.91670624941, 5571.777128914879, 5587.916181257285, 5610.214569960209, 8710.69512567057, 8815.338849586307, 8829.205371516466, 8931.19619234272, 8943.060978597283, 8714.91285087141, 8722.912770872337, 8733.956330218436, 8798.824023519493, 8826.86759698605, 6828.419584335288, 7026.051483049723, 7036.718531258794, 7070.505064645528, 7098.0, 6872.072270243453, 6892.241853396022, 6905.723771049303, 6915.273896241023, 6916.861662766616, 7686.116096648957, 7914.564698941614, 7919.049714034353, 8015.959920200595, 8066.798330041796, 7456.552606843607, 7581.355584775356, 7581.658825352762, 7722.575258360619, 7722.845543089219, 6128.8774224516155, 6349.460295874717, 6354.841128971628, 6357.841053973688, 6747.359000894907, 6927.1989282787845, 6976.337247961435, 6980.685869136003, 6981.406580440719, 6984.546004509691, 6649.501287403367, 6683.465322774264, 6740.966295168493, 6742.954841999498, 6748.358905903931, 6679.298673639198, 6729.899051514133, 6765.830854228487, 6832.897506537306, 6884.139482564679, 5872.677002764889, 6401.231852177769, 6770.221424536241, 6814.284500127415, 6817.5568588041615, 5954.583179177589, 6062.848428789315, 6093.817185484442, 6096.451319381277, 6107.969460152671, 6169.691515424301, 6209.96895015522, 6215.658138802229, 6222.688865556614, 6223.190985171898], "unit": "score", "name": "mootools.html", "value": 4237.212232614867}, {"lowerIsBetter": false, "replicates": [327.8016799836099, 331.9030603854262, 336.5843183668168, 337.1033052081463, 343.8762045663561, 5907.970460147704, 5970.701464926752, 6003.099535069742, 6023.939760602387, 6070.6661133637745, 5781.4507621775865, 5896.380880007602, 5897.380775018615, 5941.0494320908665, 5964.970175149129, 4583.3125031245245, 4584.724916505003, 4589.059242855224, 4589.128065667529, 4593.701409408378, 4372.409724687158, 4464.843730469434, 4467.106578684276, 4579.839705610304, 4597.977010114945, 4547.067851090518, 4548.613367863735, 4552.954470455303, 4558.977205113986, 4569.474510431293, 4554.066416384666, 4555.430571178586, 4555.476120246181, 4564.7032942858605, 4565.269556870918, 4010.859619913318, 4012.1574469361467, 4019.33680942647, 4023.376376661622, 4023.396490526415, 5542.667439953616, 5638.323401191842, 5659.349174844904, 5682.090865461506, 5691.601587888849, 5290.153575427951, 5292.550133238679, 5297.178937264692, 5298.814541491068, 5299.682019078868, 6086.330503644595, 6336.3663633636725, 6347.650879201642, 6351.428371446592, 6355.586886852339, 4296.37702533131, 4307.784610769449, 4386.451693538308, 4405.713628614129, 4411.250087485135, 6505.121808555832, 6550.70521826519, 6560.523882126531, 6572.737090516373, 6573.57271777333, 4492.168948744493, 4496.168208881368, 4497.775111244425, 4502.16709908668, 4506.369108324771, 4468.240399132091, 4554.840580579664, 4555.385023021916, 4557.612602928788, 4575.130725162208, 5274.235235890775, 5281.260623512634, 5281.309980806182, 5285.286486324374, 5289.9471005290225, 6371.649559274192, 6378.77674281398, 6379.617222966637, 6381.393767592164, 6386.457151142112, 1589.8092228932603, 1603.2464741571443, 1604.5747876812654, 1605.494269305165, 1606.1086097216157, 1061.1139698351808, 1072.790805792863, 1076.39721755817, 1076.4348716923678, 1098.3464838421128, 6069.635821850703, 6072.483838873745, 6082.452579267887, 6088.969555152196, 6096.512279017668, 6488.253850807123, 6521.347865213441, 6546.214454265519, 6575.671216439255, 6595.109660195908, 5947.524198064145, 6089.54328425361, 6093.055576385667, 6097.2683278006925, 6097.69511524422, 3546.982265088658, 3569.982150089285, 3571.8035508047305, 3572.1783989682517, 3575.0, 6656.400923916871, 6671.132752742113, 6677.165354330708, 6682.498812589075, 6692.498062645321, 6577.736890524326, 6725.562838415487, 6728.629925354055, 6738.427233685094, 6741.52809303344, 6654.999999999904, 6656.400923916871, 6656.667166641649, 6664.900026499607, 6667.433268172163, 6375.9362406377195, 6536.346365363615, 6550.0, 6558.1802274715665, 6558.311377305315, 6424.743010279723, 6530.967345163243, 6542.803715888531, 6579.309172536815, 6582.243042050225, 6712.496562757715, 6714.832129196614, 6723.831904202434, 6728.293529179366, 6728.663566821541, 4369.69412141147, 4460.531644177315, 4460.665450091191, 4461.531539188469, 4467.039586488921, 6616.206055273398, 6619.404253617197, 6621.238557565749, 6625.734970601122, 6627.436667883284, 6434.710438030206, 6436.356364363526, 6437.937740272802, 6441.903371449338, 6443.259025212161, 6215.844603884939, 6396.680165991775, 6413.390727880844, 6424.357564243538, 6430.620670351999, 6279.183706118175, 6292.433680968735, 6318.336574659595, 6320.6839658016, 6327.651979141191, 6445.871082578416, 6452.645104519109, 6466.321036291121, 6466.708998095003, 6479.254885688018, 6126.540509461897, 6154.1999540059505, 6263.123162757127, 6269.843253918689, 6313.43179113882], "unit": "score", "name": "prototype.html", "value": 4782.907495693259}, {"lowerIsBetter": false, "replicates": [831.2311112221194, 835.9582020898954, 842.3135144856938, 845.1675100026473, 853.884725562049, 13382.66543336417, 13705.3832577534, 13705.451781928736, 13708.725825483485, 13745.587632371033, 13125.67185820355, 15007.549773506786, 15051.698966020673, 15085.849141508581, 15111.471098511554, 831.8669012957928, 840.5881118252073, 840.6595328891808, 841.3227351981652, 841.364769598955, 689.2039694153236, 696.4811215644352, 826.3513142183388, 838.4801423117675, 839.7984483723924, 858.1375717404001, 869.1699427047155, 871.0, 871.6731225790329, 871.7602659268689, 712.1276436365463, 721.6139365439517, 861.3798065392939, 864.161763089805, 864.3344624639025, 626.4330780643479, 631.8136149835809, 633.1389310537666, 635.5709895820303, 635.6694518850218, 13705.520306789214, 13714.65713357164, 13757.243351615758, 13764.587062388144, 13779.173249604955, 12301.200421972633, 12480.75038499234, 12610.306433146174, 12736.745265094647, 13077.803832942513, 10282.794344113076, 10591.470426478645, 10916.50875710587, 10945.726356841064, 11177.0, 3684.0605645560477, 3721.274351501458, 3754.305453491113, 3836.4245363195464, 3836.808159592037, 46064.7696761514, 46487.30269045967, 46626.30060549061, 46726.532734672895, 46767.532324677, 10139.543720532447, 10372.948135259276, 10676.679699609023, 10697.625583104555, 10847.457627118612, 17904.91047544754, 17939.820601794076, 17970.0, 17971.37100201487, 17972.730409043874, 7467.7012919483695, 7527.172011078777, 7682.078150621961, 7747.225277472207, 8002.5598592077995, 4394.274944634163, 4447.466304043535, 4503.527129651339, 4523.231050721385, 4620.861374158713, 3009.6388433388133, 3032.9393412131635, 3033.6814634463503, 3036.969630303713, 3042.3763128558594, 539.0539602996715, 543.9238506609078, 546.0416968220826, 555.6027440380067, 561.2199043329775, 677.190757045336, 679.5005670831935, 710.7903168565285, 722.7867779005206, 740.1192580828797, 8291.792705182419, 8617.396782225183, 8642.22220000203, 8681.826363472695, 8756.299496040301, 609.7865746988607, 661.9503537234726, 724.2323137474294, 731.2029887422734, 758.2606958215696, 3983.223271462095, 4024.859129930497, 4132.896677583084, 4239.448871646666, 4363.52001279859, 50673.0, 53396.0, 54470.72764636151, 54844.45155548473, 55994.440055599734, 49290.014199715806, 49342.75328623406, 49752.50247497479, 50072.49927500751, 50123.0, 43267.567324326985, 43649.0, 43979.0, 44081.338779918966, 45098.09803803971, 8774.254188394058, 8856.247218986458, 8859.468431894107, 8870.911290887267, 9090.863637045317, 33256.50115248225, 33670.49494257637, 34149.146271343416, 34285.48571771475, 34481.0, 40184.1963160741, 40944.59055409408, 43974.0, 45364.0, 45916.311255330525, 11239.606613768807, 11405.885941140814, 11410.600628977945, 11546.134039947206, 11852.466639001437, 11768.76462470763, 11773.470193841127, 11888.346140961985, 12921.932272006112, 13064.21614703121, 11579.536818527165, 11861.288322700666, 11945.343006134746, 12027.939860300643, 12245.14284000147, 11487.597934072268, 11786.0, 12053.276803391824, 12067.637970860887, 12330.753384932072, 8143.633536490754, 11668.299902005907, 12003.1597788154, 12238.326892021025, 12452.066095043088, 9960.651377201762, 10532.947335263274, 10603.204759642904, 10625.415602141957, 10884.510197040994, 8310.584470776557, 9796.755081123029, 9937.304388692723, 10102.444365559964, 10230.590776368861], "unit": "score", "name": "yui.html", "value": 6407.776087133527}], "name": "dromaeo_css", "value": 6907.735878885759}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 107.0, 112.0, 112.0, 111.0, 101.0, 110.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 122.0, 157.0, 163.0, 125.0, 149.0, 164.0, 126.0, 164.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 162.0, 160.0, 161.0, 160.0, 160.0, 164.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [70.0, 73.0, 85.0, 94.0, 70.0, 73.0, 70.0, 99.0, 91.0, 71.0], "unit": "score", "name": "audio-fft", "value": 79.6}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 139.0, 92.0, 94.0, 94.0, 147.0, 93.0, 93.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 107.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 111.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 146.0, 144.0, 146.0, 145.0, 145.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [58.0, 57.0, 58.0, 56.0, 57.0, 57.0, 57.0, 67.0, 55.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 68.0, 72.0, 68.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 83.0, 83.0, 82.0, 84.0, 83.0, 89.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [130.0, 122.0, 121.0, 113.0, 116.0, 127.0, 124.0, 122.0, 114.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.3}, {"lowerIsBetter": true, "replicates": [143.0, 154.0, 152.0, 152.0, 156.0, 153.0, 152.0, 153.0, 159.0, 154.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 67.0, 67.0, 69.0, 68.0, 66.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1504.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.01650165016503], "unit": "score", "name": "Richards", "value": 213.9301200000001}, {"lowerIsBetter": false, "replicates": [189.000189000189], "unit": "score", "name": "DeltaBlue", "value": 349.8303379999999}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [2032.520325203252], "unit": "score", "name": "RayTrace", "value": 364.0745880000001}, {"lowerIsBetter": false, "replicates": [763.539282990084], "unit": "score", "name": "Earley", "value": 872.8601328671325}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [24926.829268292684], "unit": "score", "name": "RegExp", "value": 36.54636497064577}, {"lowerIsBetter": false, "replicates": [614.0672782874618], "unit": "score", "name": "Splay", "value": 132.70695717131468}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19933.51178634583}]} 23:14:40 INFO - RETURN: dromaeo_css: 6907.74 23:14:40 INFO - RETURN: kraken: 1504.20 23:14:40 INFO - RETURN: v8_7: 19933.51 23:14:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "19933.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1504.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6907.74"}}} 23:14:40 INFO - Return code: 0 23:14:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:14:40 INFO - # TBPL SUCCESS # 23:14:40 INFO - Running post-action listener: _resource_record_post_action 23:14:40 INFO - Running post-run listener: _resource_record_post_run 23:14:41 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 560447488; Read time: 12; Write time: 466036 23:14:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 233824256; Read time: 0; Write time: 221920 23:14:41 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310530048; Read time: 12; Write time: 240084 23:14:41 INFO - Running post-run listener: _upload_blobber_files 23:14:41 INFO - Blob upload gear active. 23:14:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 23:14:41 INFO - Copying logs to upload dir... 23:14:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.448831 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-17 23:14:41.374336) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 23:14:41.383564) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009956 build_url: 'https://queue.taskcluster.net/v1/task/xHbRko7eTAO9YMqin9qZKA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 23:14:41.439287) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 23:14:41.439617) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1450421139.67781-1728975698 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004542 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 23:14:41.488982) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 23:14:41.489343) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 23:14:41.489660) ========= ========= Total master_lag: 0.25 =========