builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-048 starttime: 1449248855.37 results: success (0) buildid: 20151204063817 builduid: 5b2dc9c4b20f459ca4eae59c01112534 revision: d61e62d4fc42d3b84db52ace2239986792c1d7f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:35.373389) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:35.373826) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:35.374156) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005822 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:35.400631) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:35.400944) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:35.427532) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:35.427862) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.028121 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:35.477252) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:35.477582) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:35.477992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:35.478301) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-04 09:07:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.5M=0s 2015-12-04 09:07:35 (43.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.211090 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:35.704953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:35.705270) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.098135 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:35.818377) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:35.818785) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d61e62d4fc42d3b84db52ace2239986792c1d7f9 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d61e62d4fc42d3b84db52ace2239986792c1d7f9 --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=fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-04 09:07:35,901 truncating revision to first 12 chars 2015-12-04 09:07:35,901 Setting DEBUG logging. 2015-12-04 09:07:35,901 attempt 1/10 2015-12-04 09:07:35,901 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d61e62d4fc42?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-04 09:07:36,183 unpacking tar archive at: mozilla-aurora-d61e62d4fc42/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567451 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:36.398911) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:36.399211) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:36.407257) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:36.407599) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 09:07:36.408015) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-12-04 09:07:36.408299) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:07:36 INFO - MultiFileLogger online at 20151204 09:07:36 in /builds/slave/test-pgo 09:07:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:07:36 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 09:07:36 INFO - {'append_to_log': False, 09:07:36 INFO - 'base_work_dir': '/builds/slave/test-pgo', 09:07:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:07:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 09:07:36 INFO - 'branch': 'Mozilla-Aurora', 09:07:36 INFO - 'buildbot_json_path': 'buildprops.json', 09:07:36 INFO - 'config_files': ('talos/linux_config.py',), 09:07:36 INFO - 'default_actions': ('clobber', 09:07:36 INFO - 'read-buildbot-config', 09:07:36 INFO - 'download-and-extract', 09:07:36 INFO - 'populate-webroot', 09:07:36 INFO - 'create-virtualenv', 09:07:36 INFO - 'install', 09:07:36 INFO - 'run-tests'), 09:07:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:07:36 INFO - 'download_minidump_stackwalk': True, 09:07:36 INFO - 'download_symbols': 'ondemand', 09:07:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:07:36 INFO - 'tooltool.py': '/tools/tooltool.py', 09:07:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:07:36 INFO - '/tools/misc-python/virtualenv.py')}, 09:07:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:07:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:07:36 INFO - 'installer_path': 'installer.exe', 09:07:36 INFO - 'log_level': 'info', 09:07:36 INFO - 'log_name': 'talos', 09:07:36 INFO - 'log_to_console': True, 09:07:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:07:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:07:36 INFO - 'opt_config_files': (), 09:07:36 INFO - 'pip_index': False, 09:07:36 INFO - 'sps_profile': False, 09:07:36 INFO - 'sps_profile_interval': 0, 09:07:36 INFO - 'suite': 'dromaeojs-e10s', 09:07:36 INFO - 'system_bits': '64', 09:07:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:07:36 INFO - 'title': 'talos-linux64-ix-048', 09:07:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:07:36 INFO - 'use_talos_json': True, 09:07:36 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 09:07:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:07:36 INFO - 'work_dir': 'build'} 09:07:36 INFO - ##### 09:07:36 INFO - ##### Running clobber step. 09:07:36 INFO - ##### 09:07:36 INFO - Running pre-action listener: _resource_record_pre_action 09:07:36 INFO - Running main action method: clobber 09:07:36 INFO - rmtree: /builds/slave/test-pgo/build 09:07:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 09:07:37 INFO - Running post-action listener: _resource_record_post_action 09:07:37 INFO - ##### 09:07:37 INFO - ##### Running read-buildbot-config step. 09:07:37 INFO - ##### 09:07:37 INFO - Running pre-action listener: _resource_record_pre_action 09:07:37 INFO - Running main action method: read_buildbot_config 09:07:37 INFO - Using buildbot properties: 09:07:37 INFO - { 09:07:37 INFO - "properties": { 09:07:37 INFO - "buildnumber": 2, 09:07:37 INFO - "product": "firefox", 09:07:37 INFO - "script_repo_revision": "production", 09:07:37 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 09:07:37 INFO - "repository": "", 09:07:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 09:07:37 INFO - "buildid": "20151204063817", 09:07:37 INFO - "slavename": "talos-linux64-ix-048", 09:07:37 INFO - "pgo_build": "True", 09:07:37 INFO - "basedir": "/builds/slave/test-pgo", 09:07:37 INFO - "project": "", 09:07:37 INFO - "platform": "ubuntu64_hw", 09:07:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:07:37 INFO - "slavebuilddir": "test", 09:07:37 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:07:37 INFO - "branch": "mozilla-aurora", 09:07:37 INFO - "repo_path": "releases/mozilla-aurora", 09:07:37 INFO - "stage_platform": "linux64-pgo", 09:07:37 INFO - "builduid": "5b2dc9c4b20f459ca4eae59c01112534", 09:07:37 INFO - "revision": "d61e62d4fc42d3b84db52ace2239986792c1d7f9" 09:07:37 INFO - }, 09:07:37 INFO - "sourcestamp": { 09:07:37 INFO - "repository": "", 09:07:37 INFO - "hasPatch": false, 09:07:37 INFO - "project": "", 09:07:37 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:07:37 INFO - "changes": [ 09:07:37 INFO - { 09:07:37 INFO - "category": null, 09:07:37 INFO - "files": [ 09:07:37 INFO - { 09:07:37 INFO - "url": null, 09:07:37 INFO - "name": "https://queue.taskcluster.net/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2" 09:07:37 INFO - } 09:07:37 INFO - ], 09:07:37 INFO - "repository": "", 09:07:37 INFO - "rev": "d61e62d4fc42d3b84db52ace2239986792c1d7f9", 09:07:37 INFO - "who": "cbook@mozilla.com", 09:07:37 INFO - "when": 1449248694, 09:07:37 INFO - "number": 6745093, 09:07:37 INFO - "comments": "Bug 1213281 - crash in mozilla::a11y::DocAccessible::UpdateTreeOnInsertion, r=davidb a=ritu", 09:07:37 INFO - "project": "", 09:07:37 INFO - "at": "Fri 04 Dec 2015 09:04:54", 09:07:37 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 09:07:37 INFO - "revlink": "", 09:07:37 INFO - "properties": [ 09:07:37 INFO - [ 09:07:37 INFO - "buildid", 09:07:37 INFO - "20151204063817", 09:07:37 INFO - "Change" 09:07:37 INFO - ], 09:07:37 INFO - [ 09:07:37 INFO - "builduid", 09:07:37 INFO - "5b2dc9c4b20f459ca4eae59c01112534", 09:07:37 INFO - "Change" 09:07:37 INFO - ], 09:07:37 INFO - [ 09:07:37 INFO - "pgo_build", 09:07:37 INFO - "True", 09:07:37 INFO - "Change" 09:07:37 INFO - ] 09:07:37 INFO - ], 09:07:37 INFO - "revision": "d61e62d4fc42d3b84db52ace2239986792c1d7f9" 09:07:37 INFO - } 09:07:37 INFO - ], 09:07:37 INFO - "revision": "d61e62d4fc42d3b84db52ace2239986792c1d7f9" 09:07:37 INFO - } 09:07:37 INFO - } 09:07:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2. 09:07:37 INFO - Running post-action listener: _resource_record_post_action 09:07:37 INFO - ##### 09:07:37 INFO - ##### Running download-and-extract step. 09:07:37 INFO - ##### 09:07:37 INFO - Running pre-action listener: _resource_record_pre_action 09:07:37 INFO - Running main action method: download_and_extract 09:07:37 INFO - mkdir: /builds/slave/test-pgo/build/tests 09:07:37 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')]} 09:07:37 INFO - https://queue.taskcluster.net/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:07:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/test_packages.json 09:07:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/test_packages.json 09:07:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 09:07:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 09:07:41 INFO - Downloaded 1302 bytes. 09:07:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 09:07:41 INFO - Using the following test package requirements: 09:07:41 INFO - {u'common': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'], 09:07:41 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 09:07:41 INFO - u'firefox-44.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:07:41 INFO - u'jittest': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 09:07:41 INFO - u'jsshell-linux-x86_64.zip'], 09:07:41 INFO - u'mochitest': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 09:07:41 INFO - u'firefox-44.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:07:41 INFO - u'mozbase': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'], 09:07:41 INFO - u'reftest': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 09:07:41 INFO - u'firefox-44.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:07:41 INFO - u'talos': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 09:07:41 INFO - u'firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:07:41 INFO - u'web-platform': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 09:07:41 INFO - u'firefox-44.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:07:41 INFO - u'webapprt': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'], 09:07:41 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 09:07:41 INFO - u'firefox-44.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:07:41 INFO - Downloading packages: [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:07:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:41 INFO - https://queue.taskcluster.net/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:07:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 09:07:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 09:07:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 09:07:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:07:42 INFO - Downloaded 22571749 bytes. 09:07:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:07:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 09:07:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:07:43 INFO - Return code: 0 09:07:43 INFO - Downloading packages: [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:07: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')]} 09:07:43 INFO - https://queue.taskcluster.net/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:07:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 09:07:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 09:07:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 09:07:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:07:48 INFO - Downloaded 22571749 bytes. 09:07:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 09:07:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 09:07:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 09:07:49 INFO - Return code: 0 09:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:49 INFO - https://queue.taskcluster.net/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:07:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip 09:07:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip 09:07:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip 09:07:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:07:50 INFO - Downloaded 11131970 bytes. 09:07:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 09:07:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip 09:07:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 09:07:50 INFO - Return code: 0 09:07:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:50 INFO - https://queue.taskcluster.net/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:07:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 09:07:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 09:07:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 09:07:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:07:51 INFO - Downloaded 56734461 bytes. 09:07:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 09:07:51 INFO - mkdir: /builds/slave/test-pgo/properties 09:07:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 09:07:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 09:07:51 INFO - Contents: 09:07:51 INFO - build_url:https://queue.taskcluster.net/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 09:07:51 INFO - Running post-action listener: _resource_record_post_action 09:07:51 INFO - Running post-action listener: set_extra_try_arguments 09:07:51 INFO - ##### 09:07:51 INFO - ##### Running populate-webroot step. 09:07:51 INFO - ##### 09:07:51 INFO - Running pre-action listener: _resource_record_pre_action 09:07:51 INFO - Running main action method: populate_webroot 09:07:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:07:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:07:51 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:07:51 INFO - '../fennec_ids.txt'], 09:07:51 INFO - 'tests': ['tcheck2']}, 09:07:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:07:51 INFO - '--tppagecycles', 09:07:51 INFO - '7'], 09:07:51 INFO - 'tests': ['tsvgm']}}, 09:07:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:07:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:07:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:07:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:07:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:07:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:07:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:51 INFO - 'talos_options': ['--e10s'], 09:07:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:07:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:51 INFO - 'tests': ['damp', 'tps']}, 09:07:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:51 INFO - 'talos_options': ['--e10s'], 09:07:51 INFO - 'tests': ['damp', 'tps']}, 09:07:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:07:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:07:51 INFO - 'other': {'tests': ['a11yr', 09:07:51 INFO - 'ts_paint', 09:07:51 INFO - 'tpaint', 09:07:51 INFO - 'sessionrestore', 09:07:51 INFO - 'sessionrestore_no_auto_restore']}, 09:07:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:07:51 INFO - 'tests': ['a11yr', 09:07:51 INFO - 'ts_paint', 09:07:51 INFO - 'tpaint', 09:07:51 INFO - 'sessionrestore', 09:07:51 INFO - 'sessionrestore_no_auto_restore']}, 09:07:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:07:51 INFO - 'tests': ['a11yr', 09:07:51 INFO - 'ts_paint', 09:07:51 INFO - 'tpaint', 09:07:51 INFO - 'sessionrestore', 09:07:51 INFO - 'sessionrestore_no_auto_restore']}, 09:07:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:07:51 INFO - 'tests': ['a11yr', 09:07:51 INFO - 'ts_paint', 09:07:51 INFO - 'tpaint', 09:07:51 INFO - 'sessionrestore', 09:07:51 INFO - 'sessionrestore_no_auto_restore']}, 09:07:51 INFO - 'other_l64': {'tests': ['a11yr', 09:07:51 INFO - 'ts_paint', 09:07:51 INFO - 'tpaint', 09:07:51 INFO - 'sessionrestore', 09:07:51 INFO - 'sessionrestore_no_auto_restore']}, 09:07:51 INFO - 'other_nol64': {'tests': ['a11yr', 09:07:51 INFO - 'ts_paint', 09:07:51 INFO - 'tpaint', 09:07:51 INFO - 'sessionrestore', 09:07:51 INFO - 'sessionrestore_no_auto_restore']}, 09:07:51 INFO - 'svgr': {'tests': ['tsvgx', 09:07:51 INFO - 'tsvgr_opacity', 09:07:51 INFO - 'tart', 09:07:51 INFO - 'tscrollx', 09:07:51 INFO - 'cart']}, 09:07:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:07:51 INFO - 'tests': ['tsvgx', 09:07:51 INFO - 'tsvgr_opacity', 09:07:51 INFO - 'tart', 09:07:51 INFO - 'tscrollx', 09:07:51 INFO - 'cart']}, 09:07:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:51 INFO - 'tests': ['tp5o']}, 09:07:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:51 INFO - 'talos_options': ['--e10s'], 09:07:51 INFO - 'tests': ['tp5o']}, 09:07:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:51 INFO - 'talos_options': ['--xperf_path', 09:07:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:51 INFO - 'tests': ['tp5n']}, 09:07:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:07:51 INFO - 'talos_options': ['--e10s', 09:07:51 INFO - '--xperf_path', 09:07:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:07:51 INFO - 'tests': ['tp5n']}}, 09:07:51 INFO - 'talos.zip': {'path': '', 09:07:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:07:51 INFO - Running post-action listener: _resource_record_post_action 09:07:51 INFO - ##### 09:07:51 INFO - ##### Running create-virtualenv step. 09:07:51 INFO - ##### 09:07:51 INFO - Running pre-action listener: _resource_record_pre_action 09:07:51 INFO - Running main action method: create_virtualenv 09:07:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 09:07:51 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 09:07:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 09:07:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:07:51 INFO - Using real prefix '/usr' 09:07:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 09:07:52 INFO - Installing distribute.............................................................................................................................................................................................done. 09:07:54 INFO - Installing pip.................done. 09:07:54 INFO - Return code: 0 09:07:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 09:07: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')]} 09:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19af3c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da50>, '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 0x1e79550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e799e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', '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 09:07: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 09:07: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 pip>=1.5 09:07:54 INFO - Using env: {'DISPLAY': ':0', 09:07:54 INFO - 'HOME': '/home/cltbld', 09:07:54 INFO - 'LANG': 'en_US.UTF-8', 09:07:54 INFO - 'LANGUAGE': 'en_US:en', 09:07:54 INFO - 'LOGNAME': 'cltbld', 09:07:54 INFO - 'MAIL': '/var/mail/cltbld', 09:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:54 INFO - 'MOZ_NO_REMOTE': '1', 09:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:54 INFO - 'NO_EM_RESTART': '1', 09:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:07:54 INFO - 'PWD': '/builds/slave/test-pgo', 09:07:54 INFO - 'SHELL': '/bin/bash', 09:07:54 INFO - 'SHLVL': '1', 09:07:54 INFO - 'TERM': 'linux', 09:07:54 INFO - 'TMOUT': '86400', 09:07:54 INFO - 'USER': 'cltbld', 09:07:54 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', 09:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:54 INFO - '_': '/tools/buildbot/bin/python'} 09:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:54 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 09:07:54 INFO - Cleaning up... 09:07:54 INFO - Return code: 0 09:07:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 09:07: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')]} 09:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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')]} 09:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07: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', '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 0x7f19af3c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da50>, '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 0x1e79550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e799e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', '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 09:07: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 09:07: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 psutil>=0.7.1 09:07:54 INFO - Using env: {'DISPLAY': ':0', 09:07:54 INFO - 'HOME': '/home/cltbld', 09:07:54 INFO - 'LANG': 'en_US.UTF-8', 09:07:54 INFO - 'LANGUAGE': 'en_US:en', 09:07:54 INFO - 'LOGNAME': 'cltbld', 09:07:54 INFO - 'MAIL': '/var/mail/cltbld', 09:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:54 INFO - 'MOZ_NO_REMOTE': '1', 09:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:54 INFO - 'NO_EM_RESTART': '1', 09:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:07:54 INFO - 'PWD': '/builds/slave/test-pgo', 09:07:54 INFO - 'SHELL': '/bin/bash', 09:07:54 INFO - 'SHLVL': '1', 09:07:54 INFO - 'TERM': 'linux', 09:07:54 INFO - 'TMOUT': '86400', 09:07:54 INFO - 'USER': 'cltbld', 09:07:54 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', 09:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:54 INFO - '_': '/tools/buildbot/bin/python'} 09:07:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:54 INFO - Downloading/unpacking psutil>=0.7.1 09:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:07:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 09:07:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:07:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 09:07:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:56 INFO - Installing collected packages: psutil 09:07:56 INFO - Running setup.py install for psutil 09:07:56 INFO - building 'psutil._psutil_linux' extension 09:07:56 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 09:07:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:07:56 INFO - building 'psutil._psutil_posix' extension 09:07:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:07:57 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 09:07:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:07:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:07:57 INFO - Successfully installed psutil 09:07:57 INFO - Cleaning up... 09:07:57 INFO - Return code: 0 09:07:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 09:07:57 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')]} 09:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:57 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')]} 09:07:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:57 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 0x7f19af3c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da50>, '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 0x1e79550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e799e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', '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 09:07:57 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 09:07:57 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 09:07:57 INFO - Using env: {'DISPLAY': ':0', 09:07:57 INFO - 'HOME': '/home/cltbld', 09:07:57 INFO - 'LANG': 'en_US.UTF-8', 09:07:57 INFO - 'LANGUAGE': 'en_US:en', 09:07:57 INFO - 'LOGNAME': 'cltbld', 09:07:57 INFO - 'MAIL': '/var/mail/cltbld', 09:07:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:57 INFO - 'MOZ_NO_REMOTE': '1', 09:07:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:57 INFO - 'NO_EM_RESTART': '1', 09:07:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:07:57 INFO - 'PWD': '/builds/slave/test-pgo', 09:07:57 INFO - 'SHELL': '/bin/bash', 09:07:57 INFO - 'SHLVL': '1', 09:07:57 INFO - 'TERM': 'linux', 09:07:57 INFO - 'TMOUT': '86400', 09:07:57 INFO - 'USER': 'cltbld', 09:07:57 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', 09:07:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:57 INFO - '_': '/tools/buildbot/bin/python'} 09:07:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:07:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:07:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:07:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:07:59 INFO - Installing collected packages: mozsystemmonitor 09:07:59 INFO - Running setup.py install for mozsystemmonitor 09:07:59 INFO - Successfully installed mozsystemmonitor 09:07:59 INFO - Cleaning up... 09:07:59 INFO - Return code: 0 09:07:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 09:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:07:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f19af3c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da50>, '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 0x1e79550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e799e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', '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 09:07:59 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 09:07:59 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 09:07:59 INFO - Using env: {'DISPLAY': ':0', 09:07:59 INFO - 'HOME': '/home/cltbld', 09:07:59 INFO - 'LANG': 'en_US.UTF-8', 09:07:59 INFO - 'LANGUAGE': 'en_US:en', 09:07:59 INFO - 'LOGNAME': 'cltbld', 09:07:59 INFO - 'MAIL': '/var/mail/cltbld', 09:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:07:59 INFO - 'MOZ_NO_REMOTE': '1', 09:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:07:59 INFO - 'NO_EM_RESTART': '1', 09:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:07:59 INFO - 'PWD': '/builds/slave/test-pgo', 09:07:59 INFO - 'SHELL': '/bin/bash', 09:07:59 INFO - 'SHLVL': '1', 09:07:59 INFO - 'TERM': 'linux', 09:07:59 INFO - 'TMOUT': '86400', 09:07:59 INFO - 'USER': 'cltbld', 09:07:59 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', 09:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:07:59 INFO - '_': '/tools/buildbot/bin/python'} 09:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:07:59 INFO - Downloading/unpacking blobuploader==1.2.4 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:07: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 09:08:01 INFO - Downloading blobuploader-1.2.4.tar.gz 09:08:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:08:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:08:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:08:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 09:08:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:01 INFO - Downloading docopt-0.6.1.tar.gz 09:08:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:08:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 09:08:01 INFO - Installing collected packages: blobuploader, requests, docopt 09:08:01 INFO - Running setup.py install for blobuploader 09:08:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:08:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 09:08:01 INFO - Running setup.py install for requests 09:08:02 INFO - Running setup.py install for docopt 09:08:02 INFO - Successfully installed blobuploader requests docopt 09:08:02 INFO - Cleaning up... 09:08:02 INFO - Return code: 0 09:08:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:08:02 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')]} 09:08:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:02 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')]} 09:08:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:02 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 0x7f19af3c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da50>, '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 0x1e79550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e799e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', '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 09:08:02 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 09:08:02 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 09:08:02 INFO - Using env: {'DISPLAY': ':0', 09:08:02 INFO - 'HOME': '/home/cltbld', 09:08:02 INFO - 'LANG': 'en_US.UTF-8', 09:08:02 INFO - 'LANGUAGE': 'en_US:en', 09:08:02 INFO - 'LOGNAME': 'cltbld', 09:08:02 INFO - 'MAIL': '/var/mail/cltbld', 09:08:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:02 INFO - 'MOZ_NO_REMOTE': '1', 09:08:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:02 INFO - 'NO_EM_RESTART': '1', 09:08:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:08:02 INFO - 'PWD': '/builds/slave/test-pgo', 09:08:02 INFO - 'SHELL': '/bin/bash', 09:08:02 INFO - 'SHLVL': '1', 09:08:02 INFO - 'TERM': 'linux', 09:08:02 INFO - 'TMOUT': '86400', 09:08:02 INFO - 'USER': 'cltbld', 09:08:02 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', 09:08:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:02 INFO - '_': '/tools/buildbot/bin/python'} 09:08:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:08:02 INFO - Running setup.py (path:/tmp/pip-XBExOi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:08:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:08:02 INFO - Running setup.py (path:/tmp/pip-8sDc3w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:08:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:08:02 INFO - Running setup.py (path:/tmp/pip-HKK6Dy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:08:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:08:02 INFO - Running setup.py (path:/tmp/pip-LOkLH7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:08:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:08:02 INFO - Running setup.py (path:/tmp/pip-jyY9ZQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:08:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:08:03 INFO - Running setup.py (path:/tmp/pip-W2CKDi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:08:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:08:03 INFO - Running setup.py (path:/tmp/pip-TTLnkR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:08:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:08:03 INFO - Running setup.py (path:/tmp/pip-lFLmnH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:08:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:08:03 INFO - Running setup.py (path:/tmp/pip-2Q73EL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:08:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:08:03 INFO - Running setup.py (path:/tmp/pip-njAU9X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:08:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:08:03 INFO - Running setup.py (path:/tmp/pip-_HkDBa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:08:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:08:03 INFO - Running setup.py (path:/tmp/pip-fiPve6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:08:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:08:03 INFO - Running setup.py (path:/tmp/pip-6DFFZ4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:08:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:08:03 INFO - Running setup.py (path:/tmp/pip-U97Pow-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:08:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:08:03 INFO - Running setup.py (path:/tmp/pip-p8WhXF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:08:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:08:03 INFO - Running setup.py (path:/tmp/pip-WOq3fE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:08:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:08:03 INFO - Running setup.py (path:/tmp/pip-WAKi6z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:08:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:08:03 INFO - Running setup.py install for manifestparser 09:08:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 09:08:04 INFO - Running setup.py install for mozcrash 09:08:04 INFO - Running setup.py install for mozdebug 09:08:04 INFO - Running setup.py install for mozdevice 09:08:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 09:08:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 09:08:04 INFO - Running setup.py install for mozfile 09:08:04 INFO - Running setup.py install for mozhttpd 09:08:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 09:08:04 INFO - Running setup.py install for mozinfo 09:08:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 09:08:04 INFO - Running setup.py install for mozInstall 09:08:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 09:08:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 09:08:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 09:08:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 09:08:04 INFO - Running setup.py install for mozleak 09:08:04 INFO - Running setup.py install for mozlog 09:08:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 09:08:04 INFO - Running setup.py install for moznetwork 09:08:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 09:08:05 INFO - Running setup.py install for mozprocess 09:08:05 INFO - Running setup.py install for mozprofile 09:08:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 09:08:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 09:08:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 09:08:05 INFO - Running setup.py install for mozrunner 09:08:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 09:08:05 INFO - Running setup.py install for mozscreenshot 09:08:05 INFO - Running setup.py install for moztest 09:08:05 INFO - Running setup.py install for mozversion 09:08:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 09:08:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:08:05 INFO - Cleaning up... 09:08:05 INFO - Return code: 0 09:08:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f19af3c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da50>, '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 0x1e79550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e799e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', '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 09:08:05 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 09:08:05 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 09:08:05 INFO - Using env: {'DISPLAY': ':0', 09:08:05 INFO - 'HOME': '/home/cltbld', 09:08:05 INFO - 'LANG': 'en_US.UTF-8', 09:08:05 INFO - 'LANGUAGE': 'en_US:en', 09:08:05 INFO - 'LOGNAME': 'cltbld', 09:08:05 INFO - 'MAIL': '/var/mail/cltbld', 09:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:05 INFO - 'MOZ_NO_REMOTE': '1', 09:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:05 INFO - 'NO_EM_RESTART': '1', 09:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:08:05 INFO - 'PWD': '/builds/slave/test-pgo', 09:08:05 INFO - 'SHELL': '/bin/bash', 09:08:05 INFO - 'SHLVL': '1', 09:08:05 INFO - 'TERM': 'linux', 09:08:05 INFO - 'TMOUT': '86400', 09:08:05 INFO - 'USER': 'cltbld', 09:08:05 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', 09:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:05 INFO - '_': '/tools/buildbot/bin/python'} 09:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:08:05 INFO - Running setup.py (path:/tmp/pip-_Ah4_4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 09:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 09:08:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:08:05 INFO - Running setup.py (path:/tmp/pip-ZEqsvC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 09:08:06 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)) 09:08:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:08:06 INFO - Running setup.py (path:/tmp/pip-nH_5Nx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 09:08:06 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)) 09:08:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:08:06 INFO - Running setup.py (path:/tmp/pip-QeQh_c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 09:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 09:08:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 09:08:06 INFO - Running setup.py (path:/tmp/pip-iEuM7v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 09:08:06 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)) 09:08:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:08:06 INFO - Running setup.py (path:/tmp/pip-hEgJrl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 09:08:06 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)) 09:08:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:08:06 INFO - Running setup.py (path:/tmp/pip-WWHMUo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 09:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 09:08:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:08:06 INFO - Running setup.py (path:/tmp/pip-C17wKQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 09:08:06 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)) 09:08:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 09:08:06 INFO - Running setup.py (path:/tmp/pip-pnIoOx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 09:08:06 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)) 09:08:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 09:08:06 INFO - Running setup.py (path:/tmp/pip-Zp7bwD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 09:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:08:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:08:06 INFO - Running setup.py (path:/tmp/pip-10xHzn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 09:08:06 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)) 09:08:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:08:06 INFO - Running setup.py (path:/tmp/pip-RfDq9y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 09:08:06 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)) 09:08:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:08:06 INFO - Running setup.py (path:/tmp/pip-emhEC1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 09:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 09:08:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:08:06 INFO - Running setup.py (path:/tmp/pip-8T6qUY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 09:08:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 09:08:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:08:06 INFO - Running setup.py (path:/tmp/pip-9IXuKa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 09:08:07 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)) 09:08:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 09:08:07 INFO - Running setup.py (path:/tmp/pip-kyJ971-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 09:08:07 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)) 09:08:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 09:08:07 INFO - Running setup.py (path:/tmp/pip-q2_8x0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 09:08:07 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)) 09:08:07 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)) 09:08: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.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 09:08:07 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)) 09:08: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 mozdevice==0.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:08:07 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 09:08:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08:08 INFO - Downloading blessings-1.5.1.tar.gz 09:08:08 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 09:08:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 09:08:08 INFO - Installing collected packages: blessings 09:08:08 INFO - Running setup.py install for blessings 09:08:09 INFO - Successfully installed blessings 09:08:09 INFO - Cleaning up... 09:08:09 INFO - Return code: 0 09:08:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 09:08:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:08:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:08:09 INFO - Reading from file tmpfile_stdout 09:08:09 INFO - Current package versions: 09:08:09 INFO - argparse == 1.2.1 09:08:09 INFO - blessings == 1.5.1 09:08:09 INFO - blobuploader == 1.2.4 09:08:09 INFO - docopt == 0.6.1 09:08:09 INFO - manifestparser == 1.1 09:08:09 INFO - mozInstall == 1.12 09:08:09 INFO - mozcrash == 0.16 09:08:09 INFO - mozdebug == 0.1 09:08:09 INFO - mozdevice == 0.46 09:08:09 INFO - mozfile == 1.2 09:08:09 INFO - mozhttpd == 0.7 09:08:09 INFO - mozinfo == 0.8 09:08:09 INFO - mozleak == 0.1 09:08:09 INFO - mozlog == 3.0 09:08:09 INFO - moznetwork == 0.27 09:08:09 INFO - mozprocess == 0.22 09:08:09 INFO - mozprofile == 0.27 09:08:09 INFO - mozrunner == 6.11 09:08:09 INFO - mozscreenshot == 0.1 09:08:09 INFO - mozsystemmonitor == 0.0 09:08:09 INFO - moztest == 0.7 09:08:09 INFO - mozversion == 1.4 09:08:09 INFO - psutil == 3.1.1 09:08:09 INFO - requests == 1.2.3 09:08:09 INFO - wsgiref == 0.1.2 09:08:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 09:08: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')]} 09:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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')]} 09:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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', '-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 0x7f19af3c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da50>, '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 0x1e79550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e799e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', '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 09:08:09 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 09:08:09 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 09:08:09 INFO - Using env: {'DISPLAY': ':0', 09:08:09 INFO - 'HOME': '/home/cltbld', 09:08:09 INFO - 'LANG': 'en_US.UTF-8', 09:08:09 INFO - 'LANGUAGE': 'en_US:en', 09:08:09 INFO - 'LOGNAME': 'cltbld', 09:08:09 INFO - 'MAIL': '/var/mail/cltbld', 09:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:09 INFO - 'MOZ_NO_REMOTE': '1', 09:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:09 INFO - 'NO_EM_RESTART': '1', 09:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:08:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:08:09 INFO - 'SHELL': '/bin/bash', 09:08:09 INFO - 'SHLVL': '1', 09:08:09 INFO - 'TERM': 'linux', 09:08:09 INFO - 'TMOUT': '86400', 09:08:09 INFO - 'USER': 'cltbld', 09:08:09 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', 09:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:09 INFO - '_': '/tools/buildbot/bin/python'} 09:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:09 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)) 09:08:09 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)) 09:08:09 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)) 09:08:09 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)) 09:08:09 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)) 09:08:09 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)) 09:08:09 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)) 09:08:09 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)) 09:08:09 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)) 09:08:09 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)) 09:08:09 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)) 09:08:09 INFO - Cleaning up... 09:08:09 INFO - Return code: 0 09:08:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 09:08: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')]} 09:08:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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')]} 09:08:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19af3c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da50>, '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 0x1e79550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e799e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', '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 09:08: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', 'jsonschema'] in /builds/slave/test-pgo/build 09:08: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 jsonschema 09:08:09 INFO - Using env: {'DISPLAY': ':0', 09:08:09 INFO - 'HOME': '/home/cltbld', 09:08:09 INFO - 'LANG': 'en_US.UTF-8', 09:08:09 INFO - 'LANGUAGE': 'en_US:en', 09:08:09 INFO - 'LOGNAME': 'cltbld', 09:08:09 INFO - 'MAIL': '/var/mail/cltbld', 09:08:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:09 INFO - 'MOZ_NO_REMOTE': '1', 09:08:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:09 INFO - 'NO_EM_RESTART': '1', 09:08:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:08:09 INFO - 'PWD': '/builds/slave/test-pgo', 09:08:09 INFO - 'SHELL': '/bin/bash', 09:08:09 INFO - 'SHLVL': '1', 09:08:09 INFO - 'TERM': 'linux', 09:08:09 INFO - 'TMOUT': '86400', 09:08:09 INFO - 'USER': 'cltbld', 09:08:09 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', 09:08:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:09 INFO - '_': '/tools/buildbot/bin/python'} 09:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:09 INFO - Downloading/unpacking jsonschema 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:08:11 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 09:08:11 INFO - Downloading/unpacking functools32 (from jsonschema) 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08: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 09:08:11 INFO - Downloading functools32-3.2.3-2.tar.gz 09:08:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 09:08:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 09:08:11 INFO - warning: no files found matching '*.txt' 09:08:11 INFO - no previously-included directories found matching 'build' 09:08:11 INFO - no previously-included directories found matching 'dist' 09:08:11 INFO - no previously-included directories found matching '.git*' 09:08:11 INFO - Installing collected packages: jsonschema, functools32 09:08:11 INFO - Running setup.py install for functools32 09:08:11 INFO - warning: no files found matching '*.txt' 09:08:11 INFO - no previously-included directories found matching 'build' 09:08:11 INFO - no previously-included directories found matching 'dist' 09:08:11 INFO - no previously-included directories found matching '.git*' 09:08:11 INFO - Successfully installed jsonschema functools32 09:08:11 INFO - Cleaning up... 09:08:11 INFO - Return code: 0 09:08:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 09:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:08:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:08:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:08:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f19af3c8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e7b450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f0da50>, '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 0x1e79550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e799e0>, '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': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', '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 09:08:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 09:08:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:08:11 INFO - Using env: {'DISPLAY': ':0', 09:08:11 INFO - 'HOME': '/home/cltbld', 09:08:11 INFO - 'LANG': 'en_US.UTF-8', 09:08:11 INFO - 'LANGUAGE': 'en_US:en', 09:08:11 INFO - 'LOGNAME': 'cltbld', 09:08:11 INFO - 'MAIL': '/var/mail/cltbld', 09:08:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:11 INFO - 'MOZ_NO_REMOTE': '1', 09:08:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:11 INFO - 'NO_EM_RESTART': '1', 09:08:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:08:11 INFO - 'PWD': '/builds/slave/test-pgo', 09:08:11 INFO - 'SHELL': '/bin/bash', 09:08:11 INFO - 'SHLVL': '1', 09:08:11 INFO - 'TERM': 'linux', 09:08:11 INFO - 'TMOUT': '86400', 09:08:11 INFO - 'USER': 'cltbld', 09:08:11 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', 09:08:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:11 INFO - '_': '/tools/buildbot/bin/python'} 09:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:08:12 INFO - Downloading/unpacking flake8 09:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:08:13 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 09:08:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:08:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 09:08:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:08:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:08:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:08:14 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 09:08:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:08:14 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 09:08:14 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 09:08:14 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 09:08:14 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 09:08:14 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 09:08:14 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 09:08:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 09:08:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 09:08:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:08:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:08:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:08:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:08:14 INFO - no previously-included directories found matching 'docs/_build' 09:08:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:08:14 INFO - Running setup.py install for pep8 09:08:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:08:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:08:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:08:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:08:14 INFO - no previously-included directories found matching 'docs/_build' 09:08:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 09:08:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:08:14 INFO - Cleaning up... 09:08:14 INFO - Return code: 0 09:08:14 INFO - Running post-action listener: _resource_record_post_action 09:08:14 INFO - Running post-action listener: _start_resource_monitoring 09:08:14 INFO - Starting resource monitoring. 09:08:14 INFO - ##### 09:08:14 INFO - ##### Running install step. 09:08:14 INFO - ##### 09:08:14 INFO - Running pre-action listener: _resource_record_pre_action 09:08:14 INFO - Running main action method: install 09:08:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 09:08:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 09:08:14 INFO - Reading from file tmpfile_stdout 09:08:14 INFO - Detecting whether we're running mozinstall >=1.0... 09:08:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 09:08:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 09:08:14 INFO - Reading from file tmpfile_stdout 09:08:14 INFO - Output received: 09:08:14 INFO - Usage: mozinstall [options] installer 09:08:14 INFO - Options: 09:08:14 INFO - -h, --help show this help message and exit 09:08:14 INFO - -d DEST, --destination=DEST 09:08:14 INFO - Directory to install application into. [default: 09:08:14 INFO - "/builds/slave/test-pgo"] 09:08:14 INFO - --app=APP Application being installed. [default: firefox] 09:08:14 INFO - mkdir: /builds/slave/test-pgo/build/application 09:08:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 09:08:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 09:08:29 INFO - Reading from file tmpfile_stdout 09:08:29 INFO - Output received: 09:08:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 09:08:29 INFO - Running post-action listener: _resource_record_post_action 09:08:29 INFO - ##### 09:08:29 INFO - ##### Running run-tests step. 09:08:29 INFO - ##### 09:08:29 INFO - Running pre-action listener: _resource_record_pre_action 09:08:29 INFO - Running main action method: run_tests 09:08:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 09:08:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 09:08:29 INFO - Python 2.7.3 09:08:29 INFO - Return code: 0 09:08:29 INFO - grabbing minidump binary from tooltool 09:08:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:08:29 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 0x1f0da50>, '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 0x1e79550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e799e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 09:08:29 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 09:08:29 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 09:08:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:08:29 INFO - Return code: 0 09:08:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 09:08:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 09:08:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 09:08:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 09:08:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 09:08:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 09:08:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 09:08:30 INFO - Return code: 0 09:08:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 09:08:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost 09:08:30 INFO - Using env: {'DISPLAY': ':0', 09:08:30 INFO - 'HOME': '/home/cltbld', 09:08:30 INFO - 'LANG': 'en_US.UTF-8', 09:08:30 INFO - 'LANGUAGE': 'en_US:en', 09:08:30 INFO - 'LOGNAME': 'cltbld', 09:08:30 INFO - 'MAIL': '/var/mail/cltbld', 09:08:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:08:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 09:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:08:30 INFO - 'MOZ_NO_REMOTE': '1', 09:08:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 09:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:08:30 INFO - 'NO_EM_RESTART': '1', 09:08:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 09:08:30 INFO - 'PWD': '/builds/slave/test-pgo', 09:08:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 09:08:30 INFO - 'SHELL': '/bin/bash', 09:08:30 INFO - 'SHLVL': '1', 09:08:30 INFO - 'TERM': 'linux', 09:08:30 INFO - 'TMOUT': '86400', 09:08:30 INFO - 'USER': 'cltbld', 09:08:30 INFO - 'XDG_SESSION_COOKIE': 'fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989', 09:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:08:30 INFO - '_': '/tools/buildbot/bin/python'} 09:08:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost'] with output_timeout 3600 09:08:30 INFO - mozversion INFO | application_buildid: 20151204063817 09:08:30 INFO - mozversion INFO | application_changeset: d61e62d4fc42d3b84db52ace2239986792c1d7f9 09:08:30 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 09:08:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:08:30 INFO - mozversion INFO | application_name: Firefox 09:08:30 INFO - mozversion INFO | application_remotingname: firefox-dev 09:08:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:08:30 INFO - mozversion INFO | application_vendor: Mozilla 09:08:30 INFO - mozversion INFO | application_version: 44.0a2 09:08:30 INFO - mozversion INFO | platform_buildid: 20151204063817 09:08:30 INFO - mozversion INFO | platform_changeset: d61e62d4fc42d3b84db52ace2239986792c1d7f9 09:08:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:08:30 INFO - mozversion INFO | platform_version: 44.0a2 09:08:30 INFO - 2015-12-04 09:08:30,371 DEBUG : using testdate: 1449248910 09:08:30 INFO - 2015-12-04 09:08:30,371 DEBUG : actual date: 1449248910 09:08:30 INFO - 2015-12-04 09:08:30,380 INFO : starting webserver on 'localhost:53689' 09:08:30 INFO - 2015-12-04 09:08:30,380 INFO : Starting test suite talos-linux64-ix-048.e 09:08:30 INFO - 2015-12-04 09:08:30,380 INFO : Starting test dromaeo_css 09:08:30 INFO - 2015-12-04 09:08:30,380 DEBUG : operating with platform_type : linux_ 09:08:30 INFO - 2015-12-04 09:08:30,381 INFO : Initialising browser for dromaeo_css test... 09:08:30 INFO - 2015-12-04 09:08:30,394 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYNa7Zh/profile http://localhost:53689/getInfo.html 09:08:34 INFO - 2015-12-04 09:08:34,694 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:08:34 INFO - 2015-12-04 09:08:34,694 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:08:34 INFO - 2015-12-04 09:08:34,694 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:08:34 INFO - 2015-12-04 09:08:34,695 DEBUG : BROWSER_OUTPUT: __metrics 09:08:35 INFO - 2015-12-04 09:08:35,688 INFO : Browser initialized. 09:08:35 INFO - 2015-12-04 09:08:35,689 INFO : Running cycle 1/1 for dromaeo_css test... 09:08:35 INFO - 2015-12-04 09:08:35,689 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYNa7Zh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:08:47 INFO - 2015-12-04 09:08:47,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 132702208 09:08:47 INFO - 2015-12-04 09:08:47,352 DEBUG : BROWSER_OUTPUT: 09:09:37 INFO - 2015-12-04 09:09:37,026 DEBUG : BROWSER_OUTPUT: 1449248977023 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] 09:11:44 INFO - 2015-12-04 09:11:44,679 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53689/tests/dromaeo/cssquery-ext.html) 09:11:45 INFO - 2015-12-04 09:11:45,785 DEBUG : BROWSER_OUTPUT: RSS: Main: 136970240 09:11:45 INFO - 2015-12-04 09:11:45,785 DEBUG : BROWSER_OUTPUT: 09:14:47 INFO - 2015-12-04 09:14:47,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/dromaeo/cssquery-ext.html (next: http://localhost:53689/tests/dromaeo/cssquery-jquery.html) 09:14:48 INFO - 2015-12-04 09:14:48,110 DEBUG : BROWSER_OUTPUT: RSS: Main: 136982528 09:14:48 INFO - 2015-12-04 09:14:48,110 DEBUG : BROWSER_OUTPUT: 09:17:49 INFO - 2015-12-04 09:17:49,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53689/tests/dromaeo/cssquery-mootools.html) 09:17:50 INFO - 2015-12-04 09:17:50,282 DEBUG : BROWSER_OUTPUT: RSS: Main: 134742016 09:17:50 INFO - 2015-12-04 09:17:50,282 DEBUG : BROWSER_OUTPUT: 09:20:51 INFO - 2015-12-04 09:20:51,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53689/tests/dromaeo/cssquery-prototype.html) 09:20:52 INFO - 2015-12-04 09:20:52,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 135974912 09:20:52 INFO - 2015-12-04 09:20:52,435 DEBUG : BROWSER_OUTPUT: 09:23:54 INFO - 2015-12-04 09:23:54,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53689/tests/dromaeo/cssquery-yui.html) 09:23:55 INFO - 2015-12-04 09:23:55,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 136704000 09:23:55 INFO - 2015-12-04 09:23:55,187 DEBUG : BROWSER_OUTPUT: 09:26:57 INFO - 2015-12-04 09:26:57,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/dromaeo/cssquery-yui.html (next: http://localhost:53689/tests/dromaeo/cssquery-dojo.html) 09:26:57 INFO - 2015-12-04 09:26:57,429 DEBUG : BROWSER_OUTPUT: RSS: Main: 138420224 09:26:57 INFO - 2015-12-04 09:26:57,430 DEBUG : BROWSER_OUTPUT: 09:26:57 INFO - 2015-12-04 09:26:57,430 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:26:57 INFO - 2015-12-04 09:26:57,430 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:26:57 INFO - 2015-12-04 09:26:57,430 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:26:57 INFO - 2015-12-04 09:26:57,430 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:26:57 INFO - 2015-12-04 09:26:57,431 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3427.8457469413875;3438.295149494354;3451;3460.2041530447996;3495.58053033636;5790.276215473066;5790.942090579093;5798.246227990356;5798.246227990366;5838.211841401415;5809.82570522885;5840.744239988401;5842.912356314659;5845.240118784563;5847.064469684851;5280.603954703403;5331.466853314676;5382.730863456831;5384.300040994684;5393.1101368274185;5171.276021357013;5230.607704422165;5271.973640131794;5289.127293996506;5342.893142137174;5303.496167864047;5343.438938911417;5351.652142610717;5377.892442151155;5378.865528361783;5281;5323.653962492425;5323.69569455482;5330.760115794798;5333.040052790496;5127.974360128175;5132.897342053176;5217.791288348461;5242.082635538765;5242.842714718565;5644.774209031634;5650.5479561634975;5687.289088863892;5689.715514224272;5701.600887937846;6334.239891213084;6366;6375.171227740364;6375.362463753634;6378.043293506012;6140.938590614126;6194.101855230966;6230.501559875199;6350.523710721668;6363;5893.469587737081;5960.850978725566;5962.731677074498;5969.195117565978;5983.790567330123;6191.442770150618;6399.040143978347;6429.6463694496315;6455.7740479083;6463.741450341934;6128.142060111588;6153;6179.134921111048;6179.69101544921;6232.439080482778;6261.342559031327;6346.428821406095;6388.329225431356;6406.5515413920575;6428.871422571522;6103.084537319349;6196.8760624787255;6352.555321127476;6379.489640828722;6388.520860935449;6176.722047507873;6280.874382512324;6309.968450157719;6314.8421289467215;6331.303556608769;4811;4819.180739274332;4825.445073816486;4828.95171048285;4833.927491087637;4181.707280490397;4198.076423186955;4264.189803937242;4317.633001194934;4327.069680018811;5964.582479226413;6041.365656606081;6046.3349031606485;6049.516038716892;6057.606255593372;6346.873062538723;6385;6427.678616069178;6454.2577603575255;6457.063725759738;5874.970625146932;5933.970330148321;5960.493358064527;5995.490383317467;6071.635701857903;5445.128779395278;5448.155535891943;5457.126859702428;5457.2359869618285;5463.562914966793;6445.2265728112925;6479.384458476437;6520.380563846427;6529.902051469232;6534.967325163344;6129.022607377628;6235.282942461675;6239.282482514569;6352.333005034589;6372.36276372359;6459.838504037437;6527.2167339919515;6531.706073226621;6531.804045878631;6574.934250657432;6066.272047354346;6291.402316779899;6300.464460520907;6306.747730090745;6306.810795676137;6242.1261023455845;6252.874942501216;6262.2172228471445;6346.555741098079;6362.109304697254;6120.357362476876;6144.986077297196;6147.600405973598;6159.599626024294;6246;6037.78867739627;6133.84665383369;6141.385861413823;6154.723037463235;6155.815325540241;5996.70016499182;6036.517078633787;6060.303065147388;6082.057281121433;6088.695565221809;6126.938730612636;6197.721102550306;6209.163346613545;6253.937460625336;6270.278917924315;5899.056151015817;6016.127661489147;6108.75564977396;6118.326984031842;6120.571559990758 09:26:57 INFO - 2015-12-04 09:26:57,435 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.2921348314607;619.1795870471625;623.2178615837125;687.3023880761028;699.524323460047;41434.37848432272;42275.57724422755;42437;42456.36315455271;42497.575024249745;42927.35608965868;43374.78312608432;43460.56539434605;43466.34800477995;43542.78228608853;9081.863772043425;9188.356815022951;9202.355835091546;9216.815663686722;9219.308551858603;8932.33007524435;9083;9087.091290870927;9091.727248182531;9104.36269461138;9052.321075919299;9166.12921772434;9166.358354915159;9176.632934682604;9177.265818734486;8930.732078037669;8981.865272020925;9053.683121090797;9057.320700947423;9095.681651142244;8929.151730585649;8952.552372381355;9046.547672616409;9050.547472626407;9081.591328390172;41656.1668766626;42169.578304217175;42263.57736422627;42504.3624345635;42539.574604253874;3369.6630336966355;3434.055634700477;3491.6857482826413;3669.669729724311;4293.635041021517;30985.380292394027;31803.840980794947;31867.6813231867;31873;31999.360012799847;3570.893023162828;3807.695384369244;3852.460655508231;3857.633524815138;3860.8841734748003;275703;278693;279449;279592.6020369906;279712;63016.05475917865;63167;63238.36761632417;63277;63351;67507;67836.6608166956;67903.66048169727;67978.3202167982;67979.66010170017;15562.688746225012;15760.211989400485;15866.44467443634;15908.602284942968;15938.442154524537;12632.6841828955;12636.241825490317;12681.49274029047;12738.490460381481;12817.23096614206;20981.68527472089;21355.78644213538;21388.18200452979;21426.78573214279;21462.356129316144;8595;8722.607482663296;8748.562571871382;8756.737297881074;8833.69082082124;988.802239552078;989.1641562879355;1079.3308148947704;1213.417559571393;1216.6106845809256;28770.568441473395;28807.2798180043;29005.56491652627;29239.707602924125;29349;1070.1438848920832;1082.8917108289265;1089.3028461784463;1124.9381284029457;1131.9886801131884;14748.483803067056;14973.700525989638;14997.400103995937;15363.769543456858;15415.84584154144;464094;830094;839835;840944;847359;57525;57705.42294577084;58144.709276453345;58273;58485;1477.2096928143392;1488.1443170177192;1500.0399744163963;1500.3248538157873;1514.4093803416677;29795.553066703582;30101.39797204;30596.541051884684;31139.532907006866;31293.217669558442;46567.301490476995;47361.52638473571;47403.52596474129;47422;47471.525284748095;336850;336873;337498;337939;338687;33246.667533324355;33280.833595831864;33650.83174584209;33789.32421351608;34140.487892681136;43237;43457.3481397773;43589.56410435855;44409.333859992774;44759.10481790281;36838.63161368352;37486;37767.62232377641;38214;38282;37602.24795504129;37902.24195516019;38156.6184338153;38650.22699546049;43942.56057439385;40236.59763402329;40772.79613601913;40850.59149408468;41014;41069.38395924004;33036;33755.3248935015;33782.49326260059;34058.82970585131;34130.48804267888;27200.183994480198;27730.306742331602;27869.16392508228;28050.859745701142;28153.71846281593 09:26:57 INFO - 2015-12-04 09:26:57,435 DEBUG : BROWSER_OUTPUT: |2;jquery.html;383.40380707999066;391.0926650171603;398.5357059026235;398.6053806731336;399.5225705282187;12303.138780285384;12847;17924.731129033058;20012.799872001277;20059;12837.80743288849;13373.732525349487;13552.119112257697;13565.25391103489;13682.863171368308;4864.440589332219;4958.305837182797;4981.651284410093;4982.975085124569;4986.177280748672;4831.855044348676;4918.36061312029;5017.5484206421415;5032.320636714034;5069.645124841262;4989.077020751154;4996.350474438318;4996.77514511846;5093.26147708582;5263.578913686915;5238.869028274305;5244.292020577231;5244.842654720326;5254.133068043807;5260.736963151846;4335.761533115678;4537.001859590885;4539.0921815636675;4551.431071116111;4569.474510431276;14413.13521188732;14581.125132492085;14746.336414861356;14809.111453312727;14914.552563423114;2083.802038806326;2108.5888251790907;2110.567333696604;2125.1499400239873;2236.507968246983;10674.519646615921;10681.83977240342;10857.837132443019;10962.835557466644;11143.888561114367;1762.7003409420429;1807.5210069331638;1835.1191428114446;1855.2209866266617;1860.079260765916;55804.16293755597;59779;63680;65382.673086634735;66505;7401.962990185015;7458.70165193397;7593.6582853771715;7624.656890439833;7705.537667739954;9361.812763744687;9381.718548443558;9419.434833909987;9424.057594240521;9428.669996550088;6093.177421048191;6096.847578810565;6181.84545386369;6224.813255602339;6255.499560035186;6288.151099601495;6292.119103325538;6378.202724659418;6404.071409645575;6433.8713225736155;3579.749417540799;3619.3123306571665;3642.8360723767496;3656.03115174479;3706.6664000240107;1291.341415877909;1308.6662900960384;1310.6723319170208;1311.763882501159;1351.4323983926774;493.15177894022224;547.5209191957038;568.718484350241;572.1046562130252;580.9302883653904;13136.080474366703;13282.136661116996;13372.331383430985;13495.797563036562;13534.120282181626;548.9121740521498;556.9888602227933;572.6792995922297;580.9186713860063;593.2080672302438;7213.134423869064;7300.452466065067;7304.5982470963545;7388.593627350439;7425.108986921604;425040;426783;437485;645026;645029;73130.63434682899;77927;77933;79084.60457697675;83868;593.2880543348;598.2611474828583;602.6474512410289;603.2881200183738;603.6860832367232;12025;12286.508539658313;12305.446254918372;12329.815052774395;12454.190477618926;37809;37838.62161378351;38220;38928.22143557169;39379;51724;52018.47981520136;52438.47561524488;54282.45717542774;54407.45592544182;7436.330730234305;7498.700051997859;7558.962205188939;7567.356774673995;7579.355754760686;11075.446227688422;11760.82358764602;13110.934445327712;13229.272390018641;13346.265955372548;11665.941670291933;12002.579909703118;12099.274043557414;12142.332171730639;12250;10172.440515771703;11007;11142.944285278845;11149.832752508557;11177.776444471228;11205.943970280096;11287;11487.13846461502;11538.48076836561;11573.537058517564;14081.366338514586;15334.233288335316;15525.84474155244;15697.450589229778;16186.271617776993;15926.362945482051;16261.918690406945;16512.174391280147;16539.173041348124;16745.24646390891 09:26:57 INFO - 2015-12-04 09:26:57,438 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1534.831168571457;1539.3611651164767;1709.1454272863568;1767.284249878799;1830.7070868661012;8298.460600060991;8434;8479.618417171234;8609.569521523914;8764.386492945496;8803.95598022009;8858.291336693064;8867.201951824334;8915.108489151082;8923.955380223106;2453.3498622864954;2472.295395812194;2473.950520989579;2482.2181012980855;2497.088562674629;2491.725910149891;2520.231329444519;2532.3669082729316;2535.2267558394683;2545.834520756145;2429.878506074698;2444.4255599934;2450.742672019439;2462.729099799021;2481.677381940345;2451.227863223097;2473.777360037587;2483.788877945377;2511.2842839790665;2514.421683012908;2480;2487.8880450379775;2502.4869901670295;2519.1308998395525;2524.078711270373;8589.828203435896;8621.784455388603;8624.18070283322;8669.393142480028;8694.869576956351;5251.973740131313;5330.440303768088;5337.492938170868;5339.038972984861;5346.037713211659;3439.8452069656923;3440.587129544446;3482.0424383294544;3525.5593050868642;3543.8050907200095;1064.9893501064967;1091.9344839309667;1093.240198062347;1130.4065365683;1151.7351009267832;11835.112366572455;11891.04871610269;11905.523779048914;11931;11932.343721095336;4663.906721865612;4709.058188362273;4709.811607535728;4710.8351207707565;4726.645501587394;9510.762230944143;9569.234461243084;9618.711438656852;9623.133917947418;9637.855432168522;5238.816641417532;5248.921266181011;5261.842144735664;5262.131748261494;5263.0000299942885;4837.7097374157665;4848.636352273594;4851.611871050308;4857.247126695368;4866.926996095061;3747.306748251582;3827.3302172119766;3839.8080095995088;3860.401637746154;3865.265599536079;1079.7894410590018;1139.1399493382444;1146.0545050333342;1168.0772189969998;1179.2688533109526;1031.2832581355885;1104.690686607751;1104.6962085426571;1301.1867582760774;1407.9929600351932;8041.477303975223;8058.1538938411795;8107;8173.509589424653;8360.58197090143;1194.1402190422882;1205.2105870654734;1205.487667741224;1206.1135065726685;1223.5472875036116;6359.9364006360265;6412.67936603168;6412.9679351602945;6460.095586617877;6465.644389558525;10442.321249118782;10509.421981790922;10578.312409693346;10592.258541901992;10608.045275925204;10290.794184116276;10433.5826566938;10475.266731328733;10492.055714985689;10508.842367364496;8091.0695270043525;8117.350611951029;8128.146544612849;8153.939987801547;8159.428839981144;7698.730544430918;7782.610869456617;7882.802929926797;7885.6451459685595;7907.209279072047;9135.680251191176;9347.158755712018;9361.906380936376;9420.528973551158;9428.669996550088;9434.858477122985;9557.856632150662;9595.13643772064;9653.855192171983;9681;7200.927990720235;7237.276272372931;7312.122545294599;7312.9396237546325;7329.157146928172;8079.555624440713;8085.555294458862;8091.757247282591;8100.959495202486;8133.552654603817;7329.340359367469;7763.340116089969;7888.881666775118;7987.281144697005;7989.201079891965;7311.597862117635;7370.557766534025;7388.778336649909;7445.627718614156;7463.776086717407;7537.321641052332;7542.321191092828;7570.091589009354;7572.621368931642;7592.924070759443;6704.195496540447;6799.626020568916;6902.827429314308;6934.341237582422;6976.267491913276;7007.7196912122945;7020.894686579808;7023.789286321418;7049.013138160559;7054.506184567031 09:26:57 INFO - 2015-12-04 09:26:57,440 DEBUG : BROWSER_OUTPUT: |4;prototype.html;376.62149539712584;377.562028047465;377.99433008504894;382.1077783375816;387.54850599052105;6204.6277223366515;6241.906371404421;6276.811695649132;6291.33940936202;6311.905321420177;6059.394060593939;6085.361037091097;6140.1096840958035;6203.906941395871;6207.4723648489935;4786.473487916326;4812.566868981799;4823.083614113307;4831.396075490564;4834.468208497063;4805.831795887145;4823.469418363977;4831.154547954112;4833;4844.709317440947;4708;4787.904241915159;4799.328094066834;4863.197572400567;4869.123557759602;4857.53853383928;4860.1494738420815;4864.246041863482;4872.147374209517;4877.926831097537;4324.740515569076;4326.242907491176;4328.6753493487795;4332.718373305725;4335.046289816235;5966.642001479925;6012.398760123952;6033.185519954794;6046.3651316612;6055.061465472859;5546.417626149237;5617.988762022835;5620.887582248332;5632.211490391349;5632.324121105453;6666;6669.866602667968;6670.7331706731675;6675.165604299463;6685.5320127591085;4633.86098417048;4667.486576476585;4674.994876101655;4678.970626462173;4682.3210634458155;6718.193816741973;6841.828954276083;6843.623600702009;6874.484413668944;6901.344372284675;4747.762611869462;4777.8088876445245;4786.090642777861;4793.736344501086;4798.328234047236;4848.17581011229;4850.029994001214;4850.805967761321;4860.756962151878;4865.70805751656;5547.72261386929;5549.750261238254;5555.861103472445;5557.833265002057;5563.332400111932;6522.706478208492;6604.405603495612;6637.070810086591;6648.268690444047;6669.333066693389;1733.8699597530235;1738.782652168479;1756.9912150439422;1759.24352528414;1766.0816375484933;1183.6863231243726;1187.8099504079478;1192.821076838481;1198.0894520164738;1201.5854530187246;6285.654289014148;6297.811065668037;6304.275008374096;6304.621722696653;6305.905411418832;6695.899561506581;6735;6743.527953043338;6754.223264324665;6756.662166891636;6287;6320.71556779946;6322.430981211713;6366.649834259068;6369.01280301554;3807.6763475104926;3830.7893065881644;3840.558335791364;3841.654251117413;3844.461775351453;7083.433325333961;7087.043249161297;7090.432765378758;7101.822454438577;7114.466415018895;6870.690818913161;6990.440764738809;7008.509404341749;7034.80408330585;7037;7113;7122.323379278961;7130.03744494497;7134.215236324;7148.606826624586;6929;6930.3762661360715;6954.860902782018;6968.477364197604;6982.615956122462;6796.796096117125;6861.965690171517;6878;6894;6903.309669033057;7062.540934839219;7140.6072666003865;7156.248593897566;7170.032045673767;7183.8563228736175;4810.63920205979;4836.830710925101;4845;4847.684900481458;4852.56326930578;6829.863402732017;6983.790486285419;6987.371136597731;7001.544899581511;7011.193712722898;6749;6751.358620931003;6754.696038678369;6764.8985265222045;6777.610589829172;6745.9662701686175;6751.729930802713;6754.696038678173;6761.256261811295;6771.458283337222;6569.24453687832;6658.267590565131;6691.330866913269;6696.7656132035145;6710.66446677674;6710.698018589078;6740.258571557027;6748.831279218059;6752.493562982698;6755.493337999768;6553.115329430657;6633.900491492728;6634.635095069818;6636.867262654623;6658.067870498231 09:26:57 INFO - 2015-12-04 09:26:57,441 DEBUG : BROWSER_OUTPUT: |5;yui.html;731.997163885477;768.5696010234269;876.5573385440351;889.0575989451182;916.964334237452;14994.850051499481;15418.537443876701;15440.382384704611;15534.611634709137;15568.68862622747;14182.929085354584;14234.430622775102;14265.1440913545;14294.213818239992;14363.210023448706;874.117141686896;885.8095509465463;886.5921676029035;890.7372325164059;893.5041052216018;881.5460038080394;883.6995421556669;888.0409158109227;893.7274131389923;894.8523493623577;929.7861491856877;934.5700977550301;936.1106948399014;936.2650319499195;938.1087966431883;923.007766650853;923.3305853256369;926.3422969691527;926.6432423516927;927.096081320707;673.0778832998823;675.598019178588;676.681959479044;677.3632785181962;679.3614002837317;14838.925805371013;15013.699726005529;15016.474423395239;15017.774733379008;15023.02350347224;11108.666739997812;11348.262362946381;11384.487698053608;11458.828117578243;11703.765924681544;10869.45652717361;11072.28030178044;11244.831327530093;11247.83128253077;11285.548578056867;3500;3517.8416971236356;3519.1202199450136;3525.5240542526685;3526.9118272043147;48883;49144.75427622839;49518;50063.2490512639;50118;8246.134155913544;8290.336773058141;8372.623231954454;8374.958125209336;8397.6221070052;13862.514811981733;13867.4453021878;13886.375113119933;13923.86076139246;13931.930340348234;7162.212156662763;7190.532615379983;7305.525140865827;7305.853882922312;7430.665620047111;4253.21315556623;4273.380359847867;4296.0978194578865;4344.304911214191;4344.85626039444;2987.865546050433;3008.473517134493;3024.652165001009;3024.894128705485;3025.788194826385;467.525461656419;470.06457150270717;478.7797613098014;478.8754923719858;481.76634332348783;554.978838936359;616.9660668663176;618.9938100619026;626.8622450252776;704.4927652090487;7639.847203055908;7693.230676932262;7698;7792.688292468351;7865.252800983897;664.9335066493312;702.3924305475726;718.4252597921642;720.6144712578745;738.7045181927272;4293.184294984006;4348;4447.666425018137;4493.977530112328;4500.752458614807;62876.68561657162;63421.36578634154;64222;64417.35582644113;64928.35071649317;58540;58560;59240.40759592435;59437;60421.69789151026;53600.73199633977;54257;54279;54499;54816.72591637016;8951.910480895107;8999.955000224956;9143.771405714644;9298.116678915492;9335.299852510952;40558.18883622252;41187.588124119575;41527.961800954006;41945.37081943712;42130.578694212665;47237;51061.744691276304;53092.20361694501;53337.466625334804;54086.72956635192;8391.874121888055;8429.831403372022;8506;8538.402311838112;8547.487150770974;12862.549810756578;13764.65588360299;14099.436022558983;14328.928355358157;14385.136891786107;11509.712257193638;11695.649130526097;11964.222325549159;11974.46114924813;12506.062045346818;12446.377681115728;12489.31308778026;12753.04749373115;12755.681107972376;13088.934555327163;11766.647000589654;11825.763484730085;11943.880561194625;11999.100067494799;12310.630681079581;9965.202783777426;10218.131458826083;10330.741731456774;10546.472676366304;10700.785984280426;9725;9735.70792876215;9795.559199835881;9866.753331166778;10443.791124177626 09:26:57 INFO - 2015-12-04 09:26:57,441 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:26:57 INFO - 2015-12-04 09:26:57,442 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:26:57 INFO - 2015-12-04 09:26:57,442 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,287 09:26:57 INFO - 2015-12-04 09:26:57,442 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:26:57 INFO - 2015-12-04 09:26:57,442 DEBUG : BROWSER_OUTPUT: __startTimestamp1449250017429__endTimestamp 09:26:57 INFO - 2015-12-04 09:26:57,442 DEBUG : BROWSER_OUTPUT: 09:26:57 INFO - 2015-12-04 09:26:57,442 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:26:57 INFO - 2015-12-04 09:26:57,442 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:26:57 INFO - 2015-12-04 09:26:57,442 DEBUG : BROWSER_OUTPUT: 09:26:57 INFO - 2015-12-04 09:26:57,442 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5839.80 Median:6082.06 stddev:671.97 (11.0%) stddev-sans-first:646.84 09:26:57 INFO - 2015-12-04 09:26:57,442 DEBUG : BROWSER_OUTPUT: Values: 3427.8 3438.3 3451.0 3460.2 3495.6 5790.3 5790.9 5798.2 5798.2 5838.2 5809.8 5840.7 5842.9 5845.2 5847.1 5280.6 5331.5 5382.7 5384.3 5393.1 5171.3 5230.6 5272.0 5289.1 5342.9 5303.5 5343.4 5351.7 5377.9 5378.9 5281.0 5323.7 5323.7 5330.8 5333.0 5128.0 5132.9 5217.8 5242.1 5242.8 5644.8 5650.5 5687.3 5689.7 5701.6 6334.2 6366.0 6375.2 6375.4 6378.0 6140.9 6194.1 6230.5 6350.5 6363.0 5893.5 5960.9 5962.7 5969.2 5983.8 6191.4 6399.0 6429.6 6455.8 6463.7 6128.1 6153.0 6179.1 6179.7 6232.4 6261.3 6346.4 6388.3 6406.6 6428.9 6103.1 6196.9 6352.6 6379.5 6388.5 6176.7 6280.9 6310.0 6314.8 6331.3 4811.0 4819.2 4825.4 4829.0 4833.9 4181.7 4198.1 4264.2 4317.6 4327.1 5964.6 6041.4 6046.3 6049.5 6057.6 6346.9 6385.0 6427.7 6454.3 6457.1 5875.0 5934.0 5960.5 5995.5 6071.6 5445.1 5448.2 5457.1 5457.2 5463.6 6445.2 6479.4 6520.4 6529.9 6535.0 6129.0 6235.3 6239.3 6352.3 6372.4 6459.8 6527.2 6531.7 6531.8 6574.9 6066.3 6291.4 6300.5 6306.7 6306.8 6242.1 6252.9 6262.2 6346.6 6362.1 6120.4 6145.0 6147.6 6159.6 6246.0 6037.8 6133.8 6141.4 6154.7 6155.8 5996.7 6036.5 6060.3 6082.1 6088.7 6126.9 6197.7 6209.2 6253.9 6270.3 5899.1 6016.1 6108.8 6118.3 6120.6 09:26:57 INFO - 2015-12-04 09:26:57,443 DEBUG : BROWSER_OUTPUT: 09:26:57 INFO - 2015-12-04 09:26:57,443 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:61772.18 Median:39443.41 stddev:139318.01 (353.2%) stddev-sans-first:139633.05 09:26:57 INFO - 2015-12-04 09:26:57,443 DEBUG : BROWSER_OUTPUT: Values: 566.3 619.2 623.2 687.3 699.5 41434.4 42275.6 42437.0 42456.4 42497.6 42927.4 43374.8 43460.6 43466.3 43542.8 9081.9 9188.4 9202.4 9216.8 9219.3 8932.3 9083.0 9087.1 9091.7 9104.4 9052.3 9166.1 9166.4 9176.6 9177.3 8930.7 8981.9 9053.7 9057.3 9095.7 8929.2 8952.6 9046.5 9050.5 9081.6 41656.2 42169.6 42263.6 42504.4 42539.6 3369.7 3434.1 3491.7 3669.7 4293.6 30985.4 31803.8 31867.7 31873.0 31999.4 3570.9 3807.7 3852.5 3857.6 3860.9 275703.0 278693.0 279449.0 279592.6 279712.0 63016.1 63167.0 63238.4 63277.0 63351.0 67507.0 67836.7 67903.7 67978.3 67979.7 15562.7 15760.2 15866.4 15908.6 15938.4 12632.7 12636.2 12681.5 12738.5 12817.2 20981.7 21355.8 21388.2 21426.8 21462.4 8595.0 8722.6 8748.6 8756.7 8833.7 988.8 989.2 1079.3 1213.4 1216.6 28770.6 28807.3 29005.6 29239.7 29349.0 1070.1 1082.9 1089.3 1124.9 1132.0 14748.5 14973.7 14997.4 15363.8 15415.8 464094.0 830094.0 839835.0 840944.0 847359.0 57525.0 57705.4 58144.7 58273.0 58485.0 1477.2 1488.1 1500.0 1500.3 1514.4 29795.6 30101.4 30596.5 31139.5 31293.2 46567.3 47361.5 47403.5 47422.0 47471.5 336850.0 336873.0 337498.0 337939.0 338687.0 33246.7 33280.8 33650.8 33789.3 34140.5 43237.0 43457.3 43589.6 44409.3 44759.1 36838.6 37486.0 37767.6 38214.0 38282.0 37602.2 37902.2 38156.6 38650.2 43942.6 40236.6 40772.8 40850.6 41014.0 41069.4 33036.0 33755.3 33782.5 34058.8 34130.5 27200.2 27730.3 27869.2 28050.9 28153.7 09:26:57 INFO - 2015-12-04 09:26:57,443 DEBUG : BROWSER_OUTPUT: 09:26:57 INFO - 2015-12-04 09:26:57,443 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27441.85 Median:425911.50 stddev:86385.08 (20.3%) stddev-sans-first:86603.52 09:26:57 INFO - 2015-12-04 09:26:57,444 DEBUG : BROWSER_OUTPUT: Values: 383.4 391.1 398.5 398.6 399.5 12303.1 12847.0 17924.7 20012.8 20059.0 12837.8 13373.7 13552.1 13565.3 13682.9 4864.4 4958.3 4981.7 4983.0 4986.2 4831.9 4918.4 5017.5 5032.3 5069.6 4989.1 4996.4 4996.8 5093.3 5263.6 5238.9 5244.3 5244.8 5254.1 5260.7 4335.8 4537.0 4539.1 4551.4 4569.5 14413.1 14581.1 14746.3 14809.1 14914.6 2083.8 2108.6 2110.6 2125.1 2236.5 10674.5 10681.8 10857.8 10962.8 11143.9 1762.7 1807.5 1835.1 1855.2 1860.1 55804.2 59779.0 63680.0 65382.7 66505.0 7402.0 7458.7 7593.7 7624.7 7705.5 9361.8 9381.7 9419.4 9424.1 9428.7 6093.2 6096.8 6181.8 6224.8 6255.5 6288.2 6292.1 6378.2 6404.1 6433.9 3579.7 3619.3 3642.8 3656.0 3706.7 1291.3 1308.7 1310.7 1311.8 1351.4 493.2 547.5 568.7 572.1 580.9 13136.1 13282.1 13372.3 13495.8 13534.1 548.9 557.0 572.7 580.9 593.2 7213.1 7300.5 7304.6 7388.6 7425.1 425040.0 426783.0 437485.0 645026.0 645029.0 73130.6 77927.0 77933.0 79084.6 83868.0 593.3 598.3 602.6 603.3 603.7 12025.0 12286.5 12305.4 12329.8 12454.2 37809.0 37838.6 38220.0 38928.2 39379.0 51724.0 52018.5 52438.5 54282.5 54407.5 7436.3 7498.7 7559.0 7567.4 7579.4 11075.4 11760.8 13110.9 13229.3 13346.3 11665.9 12002.6 12099.3 12142.3 12250.0 10172.4 11007.0 11142.9 11149.8 11177.8 11205.9 11287.0 11487.1 11538.5 11573.5 14081.4 15334.2 15525.8 15697.5 16186.3 15926.4 16261.9 16512.2 16539.2 16745.2 09:26:57 INFO - 2015-12-04 09:26:57,444 DEBUG : BROWSER_OUTPUT: 09:26:57 INFO - 2015-12-04 09:26:57,445 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:6005.51 Median:5296.72 stddev:3131.27 (59.1%) stddev-sans-first:3122.03 09:26:57 INFO - 2015-12-04 09:26:57,445 DEBUG : BROWSER_OUTPUT: Values: 1534.8 1539.4 1709.1 1767.3 1830.7 8298.5 8434.0 8479.6 8609.6 8764.4 8804.0 8858.3 8867.2 8915.1 8924.0 2453.3 2472.3 2474.0 2482.2 2497.1 2491.7 2520.2 2532.4 2535.2 2545.8 2429.9 2444.4 2450.7 2462.7 2481.7 2451.2 2473.8 2483.8 2511.3 2514.4 2480.0 2487.9 2502.5 2519.1 2524.1 8589.8 8621.8 8624.2 8669.4 8694.9 5252.0 5330.4 5337.5 5339.0 5346.0 3439.8 3440.6 3482.0 3525.6 3543.8 1065.0 1091.9 1093.2 1130.4 1151.7 11835.1 11891.0 11905.5 11931.0 11932.3 4663.9 4709.1 4709.8 4710.8 4726.6 9510.8 9569.2 9618.7 9623.1 9637.9 5238.8 5248.9 5261.8 5262.1 5263.0 4837.7 4848.6 4851.6 4857.2 4866.9 3747.3 3827.3 3839.8 3860.4 3865.3 1079.8 1139.1 1146.1 1168.1 1179.3 1031.3 1104.7 1104.7 1301.2 1408.0 8041.5 8058.2 8107.0 8173.5 8360.6 1194.1 1205.2 1205.5 1206.1 1223.5 6359.9 6412.7 6413.0 6460.1 6465.6 10442.3 10509.4 10578.3 10592.3 10608.0 10290.8 10433.6 10475.3 10492.1 10508.8 8091.1 8117.4 8128.1 8153.9 8159.4 7698.7 7782.6 7882.8 7885.6 7907.2 9135.7 9347.2 9361.9 9420.5 9428.7 9434.9 9557.9 9595.1 9653.9 9681.0 7200.9 7237.3 7312.1 7312.9 7329.2 8079.6 8085.6 8091.8 8101.0 8133.6 7329.3 7763.3 7888.9 7987.3 7989.2 7311.6 7370.6 7388.8 7445.6 7463.8 7537.3 7542.3 7570.1 7572.6 7592.9 6704.2 6799.6 6902.8 6934.3 6976.3 7007.7 7020.9 7023.8 7049.0 7054.5 09:26:57 INFO - 2015-12-04 09:26:57,445 DEBUG : BROWSER_OUTPUT: 09:26:57 INFO - 2015-12-04 09:26:57,445 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5603.30 Median:6294.58 stddev:1659.58 (26.4%) stddev-sans-first:1617.20 09:26:57 INFO - 2015-12-04 09:26:57,446 DEBUG : BROWSER_OUTPUT: Values: 376.6 377.6 378.0 382.1 387.5 6204.6 6241.9 6276.8 6291.3 6311.9 6059.4 6085.4 6140.1 6203.9 6207.5 4786.5 4812.6 4823.1 4831.4 4834.5 4805.8 4823.5 4831.2 4833.0 4844.7 4708.0 4787.9 4799.3 4863.2 4869.1 4857.5 4860.1 4864.2 4872.1 4877.9 4324.7 4326.2 4328.7 4332.7 4335.0 5966.6 6012.4 6033.2 6046.4 6055.1 5546.4 5618.0 5620.9 5632.2 5632.3 6666.0 6669.9 6670.7 6675.2 6685.5 4633.9 4667.5 4675.0 4679.0 4682.3 6718.2 6841.8 6843.6 6874.5 6901.3 4747.8 4777.8 4786.1 4793.7 4798.3 4848.2 4850.0 4850.8 4860.8 4865.7 5547.7 5549.8 5555.9 5557.8 5563.3 6522.7 6604.4 6637.1 6648.3 6669.3 1733.9 1738.8 1757.0 1759.2 1766.1 1183.7 1187.8 1192.8 1198.1 1201.6 6285.7 6297.8 6304.3 6304.6 6305.9 6695.9 6735.0 6743.5 6754.2 6756.7 6287.0 6320.7 6322.4 6366.6 6369.0 3807.7 3830.8 3840.6 3841.7 3844.5 7083.4 7087.0 7090.4 7101.8 7114.5 6870.7 6990.4 7008.5 7034.8 7037.0 7113.0 7122.3 7130.0 7134.2 7148.6 6929.0 6930.4 6954.9 6968.5 6982.6 6796.8 6862.0 6878.0 6894.0 6903.3 7062.5 7140.6 7156.2 7170.0 7183.9 4810.6 4836.8 4845.0 4847.7 4852.6 6829.9 6983.8 6987.4 7001.5 7011.2 6749.0 6751.4 6754.7 6764.9 6777.6 6746.0 6751.7 6754.7 6761.3 6771.5 6569.2 6658.3 6691.3 6696.8 6710.7 6710.7 6740.3 6748.8 6752.5 6755.5 6553.1 6633.9 6634.6 6636.9 6658.1 09:26:57 INFO - 2015-12-04 09:26:57,446 DEBUG : BROWSER_OUTPUT: 09:26:57 INFO - 2015-12-04 09:26:57,446 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14869.77 Median:50589.87 stddev:18164.78 (35.9%) stddev-sans-first:18184.72 09:26:57 INFO - 2015-12-04 09:26:57,446 DEBUG : BROWSER_OUTPUT: Values: 732.0 768.6 876.6 889.1 917.0 14994.9 15418.5 15440.4 15534.6 15568.7 14182.9 14234.4 14265.1 14294.2 14363.2 874.1 885.8 886.6 890.7 893.5 881.5 883.7 888.0 893.7 894.9 929.8 934.6 936.1 936.3 938.1 923.0 923.3 926.3 926.6 927.1 673.1 675.6 676.7 677.4 679.4 14838.9 15013.7 15016.5 15017.8 15023.0 11108.7 11348.3 11384.5 11458.8 11703.8 10869.5 11072.3 11244.8 11247.8 11285.5 3500.0 3517.8 3519.1 3525.5 3526.9 48883.0 49144.8 49518.0 50063.2 50118.0 8246.1 8290.3 8372.6 8375.0 8397.6 13862.5 13867.4 13886.4 13923.9 13931.9 7162.2 7190.5 7305.5 7305.9 7430.7 4253.2 4273.4 4296.1 4344.3 4344.9 2987.9 3008.5 3024.7 3024.9 3025.8 467.5 470.1 478.8 478.9 481.8 555.0 617.0 619.0 626.9 704.5 7639.8 7693.2 7698.0 7792.7 7865.3 664.9 702.4 718.4 720.6 738.7 4293.2 4348.0 4447.7 4494.0 4500.8 62876.7 63421.4 64222.0 64417.4 64928.4 58540.0 58560.0 59240.4 59437.0 60421.7 53600.7 54257.0 54279.0 54499.0 54816.7 8951.9 9000.0 9143.8 9298.1 9335.3 40558.2 41187.6 41528.0 41945.4 42130.6 47237.0 51061.7 53092.2 53337.5 54086.7 8391.9 8429.8 8506.0 8538.4 8547.5 12862.5 13764.7 14099.4 14328.9 14385.1 11509.7 11695.6 11964.2 11974.5 12506.1 12446.4 12489.3 12753.0 12755.7 13088.9 11766.6 11825.8 11943.9 11999.1 12310.6 9965.2 10218.1 10330.7 10546.5 10700.8 9725.0 9735.7 9795.6 9866.8 10443.8 09:26:57 INFO - 2015-12-04 09:26:57,447 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:26:57 INFO - 2015-12-04 09:26:57,447 DEBUG : BROWSER_OUTPUT: 09:26:58 INFO - 2015-12-04 09:26:58,060 INFO : Browser exited with error code: 0 09:26:58 INFO - 2015-12-04 09:26:58,082 INFO : Completed test dromaeo_css (00:18:27) 09:26:58 INFO - 2015-12-04 09:26:58,082 INFO : Starting test kraken 09:26:58 INFO - 2015-12-04 09:26:58,082 DEBUG : operating with platform_type : linux_ 09:26:58 INFO - 2015-12-04 09:26:58,082 INFO : Initialising browser for kraken test... 09:26:58 INFO - 2015-12-04 09:26:58,088 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1wf0_M/profile http://localhost:53689/getInfo.html 09:27:02 INFO - 2015-12-04 09:27:02,188 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:27:02 INFO - 2015-12-04 09:27:02,188 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:27:02 INFO - 2015-12-04 09:27:02,188 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:27:02 INFO - 2015-12-04 09:27:02,188 DEBUG : BROWSER_OUTPUT: __metrics 09:27:02 INFO - 2015-12-04 09:27:02,972 INFO : Browser initialized. 09:27:02 INFO - 2015-12-04 09:27:02,973 INFO : Running cycle 1/1 for kraken test... 09:27:02 INFO - 2015-12-04 09:27:02,973 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp1wf0_M/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:27:14 INFO - 2015-12-04 09:27:14,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 133607424 09:27:14 INFO - 2015-12-04 09:27:14,686 DEBUG : BROWSER_OUTPUT: 09:27:17 INFO - 2015-12-04 09:27:17,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53689/tests/kraken/driver.html?testName=audio-beat-detection) 09:27:17 INFO - 2015-12-04 09:27:17,708 DEBUG : BROWSER_OUTPUT: RSS: Main: 133787648 09:27:17 INFO - 2015-12-04 09:27:17,708 DEBUG : BROWSER_OUTPUT: 09:27:20 INFO - 2015-12-04 09:27:20,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53689/tests/kraken/driver.html?testName=audio-dft) 09:27:20 INFO - 2015-12-04 09:27:20,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 133144576 09:27:20 INFO - 2015-12-04 09:27:20,920 DEBUG : BROWSER_OUTPUT: 09:27:23 INFO - 2015-12-04 09:27:23,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53689/tests/kraken/driver.html?testName=audio-fft) 09:27:24 INFO - 2015-12-04 09:27:24,309 DEBUG : BROWSER_OUTPUT: RSS: Main: 135196672 09:27:24 INFO - 2015-12-04 09:27:24,309 DEBUG : BROWSER_OUTPUT: 09:27:26 INFO - 2015-12-04 09:27:26,322 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53689/tests/kraken/driver.html?testName=audio-oscillator) 09:27:26 INFO - 2015-12-04 09:27:26,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 135290880 09:27:26 INFO - 2015-12-04 09:27:26,904 DEBUG : BROWSER_OUTPUT: 09:27:29 INFO - 2015-12-04 09:27:29,046 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53689/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:27:29 INFO - 2015-12-04 09:27:29,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 136065024 09:27:29 INFO - 2015-12-04 09:27:29,628 DEBUG : BROWSER_OUTPUT: 09:27:32 INFO - 2015-12-04 09:27:32,629 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53689/tests/kraken/driver.html?testName=imaging-darkroom) 09:27:33 INFO - 2015-12-04 09:27:33,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 135507968 09:27:33 INFO - 2015-12-04 09:27:33,211 DEBUG : BROWSER_OUTPUT: 09:27:36 INFO - 2015-12-04 09:27:36,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53689/tests/kraken/driver.html?testName=imaging-desaturate) 09:27:37 INFO - 2015-12-04 09:27:37,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 135458816 09:27:37 INFO - 2015-12-04 09:27:37,179 DEBUG : BROWSER_OUTPUT: 09:27:39 INFO - 2015-12-04 09:27:39,970 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53689/tests/kraken/driver.html?testName=json-parse-financial) 09:27:40 INFO - 2015-12-04 09:27:40,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 135376896 09:27:40 INFO - 2015-12-04 09:27:40,556 DEBUG : BROWSER_OUTPUT: 09:27:42 INFO - 2015-12-04 09:27:42,124 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53689/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:27:42 INFO - 2015-12-04 09:27:42,697 DEBUG : BROWSER_OUTPUT: RSS: Main: 134524928 09:27:42 INFO - 2015-12-04 09:27:42,698 DEBUG : BROWSER_OUTPUT: 09:27:44 INFO - 2015-12-04 09:27:44,449 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53689/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:27:45 INFO - 2015-12-04 09:27:45,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 135438336 09:27:45 INFO - 2015-12-04 09:27:45,056 DEBUG : BROWSER_OUTPUT: 09:27:47 INFO - 2015-12-04 09:27:47,089 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53689/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:27:47 INFO - 2015-12-04 09:27:47,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 135860224 09:27:47 INFO - 2015-12-04 09:27:47,682 DEBUG : BROWSER_OUTPUT: 09:27:50 INFO - 2015-12-04 09:27:50,045 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:27:50 INFO - 2015-12-04 09:27:50,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 136593408 09:27:50 INFO - 2015-12-04 09:27:50,640 DEBUG : BROWSER_OUTPUT: 09:27:53 INFO - 2015-12-04 09:27:53,147 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:27:53 INFO - 2015-12-04 09:27:53,729 DEBUG : BROWSER_OUTPUT: RSS: Main: 135745536 09:27:53 INFO - 2015-12-04 09:27:53,729 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-12-04 09:27:55,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53689/tests/kraken/driver.html?testName=ai-astar) 09:27:55 INFO - 2015-12-04 09:27:55,600 DEBUG : BROWSER_OUTPUT: RSS: Main: 136757248 09:27:55 INFO - 2015-12-04 09:27:55,600 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-12-04 09:27:55,604 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:27:55 INFO - 2015-12-04 09:27:55,604 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:27:55 INFO - 2015-12-04 09:27:55,604 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:27:55 INFO - 2015-12-04 09:27:55,604 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:27:55 INFO - 2015-12-04 09:27:55,604 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;104;111;108;109;118;108;108;109;109 09:27:55 INFO - 2015-12-04 09:27:55,604 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;121;160;166;124;146;156;122;163;123 09:27:55 INFO - 2015-12-04 09:27:55,604 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;163;161;162;160;160;162;163 09:27:55 INFO - 2015-12-04 09:27:55,604 DEBUG : BROWSER_OUTPUT: |3;audio-fft;70;71;71;154;72;72;72;71;162;70 09:27:55 INFO - 2015-12-04 09:27:55,604 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;89;131;90;89;90;133;89;91;134 09:27:55 INFO - 2015-12-04 09:27:55,604 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;111;111;111;110;110;110;111;110;110 09:27:55 INFO - 2015-12-04 09:27:55,604 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;145;147;148;147;146;146;146;147;146 09:27:55 INFO - 2015-12-04 09:27:55,605 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;96;96;96;95;96;96;96;96 09:27:55 INFO - 2015-12-04 09:27:55,605 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;58;61;59;61;61;60;65;56;57 09:27:55 INFO - 2015-12-04 09:27:55,605 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;61;61;61;60;61;61;62;61;61;61 09:27:55 INFO - 2015-12-04 09:27:55,605 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;90;80;83;81;82;81;81;87;83;81 09:27:55 INFO - 2015-12-04 09:27:55,605 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;110;108;117;111;109;116;127;113;108 09:27:55 INFO - 2015-12-04 09:27:55,605 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;141;141;156;144;133;143;140;154;137 09:27:55 INFO - 2015-12-04 09:27:55,605 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;66;61;65;62;63;62;62;63;63 09:27:55 INFO - 2015-12-04 09:27:55,605 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:27:55 INFO - 2015-12-04 09:27:55,605 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:27:55 INFO - 2015-12-04 09:27:55,605 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,699 09:27:55 INFO - 2015-12-04 09:27:55,605 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:27:55 INFO - 2015-12-04 09:27:55,605 DEBUG : BROWSER_OUTPUT: __startTimestamp1449250075601__endTimestamp 09:27:55 INFO - 2015-12-04 09:27:55,605 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-12-04 09:27:55,606 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:27:55 INFO - 2015-12-04 09:27:55,607 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:27:55 INFO - 2015-12-04 09:27:55,607 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-12-04 09:27:55,607 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.30 Median:109.00 stddev:3.53 (3.2%) stddev-sans-first:3.74 09:27:55 INFO - 2015-12-04 09:27:55,607 DEBUG : BROWSER_OUTPUT: Values: 109.0 104.0 111.0 108.0 109.0 118.0 108.0 108.0 109.0 109.0 09:27:55 INFO - 2015-12-04 09:27:55,607 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-12-04 09:27:55,607 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.50 Median:155.00 stddev:18.86 (12.2%) stddev-sans-first:19.62 09:27:55 INFO - 2015-12-04 09:27:55,607 DEBUG : BROWSER_OUTPUT: Values: 154.0 121.0 160.0 166.0 124.0 146.0 156.0 122.0 163.0 123.0 09:27:55 INFO - 2015-12-04 09:27:55,607 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-12-04 09:27:55,607 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.12 09:27:55 INFO - 2015-12-04 09:27:55,608 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 163.0 161.0 162.0 160.0 160.0 162.0 163.0 09:27:55 INFO - 2015-12-04 09:27:55,608 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-12-04 09:27:55,608 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.50 Median:71.00 stddev:36.69 (51.7%) stddev-sans-first:38.30 09:27:55 INFO - 2015-12-04 09:27:55,608 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 71.0 154.0 72.0 72.0 72.0 71.0 162.0 70.0 09:27:55 INFO - 2015-12-04 09:27:55,608 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-12-04 09:27:55,609 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.70 Median:89.50 stddev:20.70 (23.1%) stddev-sans-first:21.52 09:27:55 INFO - 2015-12-04 09:27:55,609 DEBUG : BROWSER_OUTPUT: Values: 91.0 89.0 131.0 90.0 89.0 90.0 133.0 89.0 91.0 134.0 09:27:55 INFO - 2015-12-04 09:27:55,609 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-12-04 09:27:55,609 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:27:55 INFO - 2015-12-04 09:27:55,609 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 111.0 111.0 110.0 110.0 110.0 111.0 110.0 110.0 09:27:55 INFO - 2015-12-04 09:27:55,610 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-12-04 09:27:55,610 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 09:27:55 INFO - 2015-12-04 09:27:55,611 DEBUG : BROWSER_OUTPUT: Values: 146.0 145.0 147.0 148.0 147.0 146.0 146.0 146.0 147.0 146.0 09:27:55 INFO - 2015-12-04 09:27:55,611 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-12-04 09:27:55,611 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 09:27:55 INFO - 2015-12-04 09:27:55,612 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 09:27:55 INFO - 2015-12-04 09:27:55,612 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-12-04 09:27:55,612 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.00 Median:61.00 stddev:2.62 (4.3%) stddev-sans-first:2.68 09:27:55 INFO - 2015-12-04 09:27:55,612 DEBUG : BROWSER_OUTPUT: Values: 62.0 58.0 61.0 59.0 61.0 61.0 60.0 65.0 56.0 57.0 09:27:55 INFO - 2015-12-04 09:27:55,612 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-12-04 09:27:55,612 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 09:27:55 INFO - 2015-12-04 09:27:55,612 DEBUG : BROWSER_OUTPUT: Values: 61.0 61.0 61.0 60.0 61.0 61.0 62.0 61.0 61.0 61.0 09:27:55 INFO - 2015-12-04 09:27:55,613 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-12-04 09:27:55,613 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.50 stddev:3.18 (3.9%) stddev-sans-first:2.09 09:27:55 INFO - 2015-12-04 09:27:55,613 DEBUG : BROWSER_OUTPUT: Values: 90.0 80.0 83.0 81.0 82.0 81.0 81.0 87.0 83.0 81.0 09:27:55 INFO - 2015-12-04 09:27:55,613 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-12-04 09:27:55,613 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:113.80 Median:114.50 stddev:6.05 (5.3%) stddev-sans-first:6.12 09:27:55 INFO - 2015-12-04 09:27:55,613 DEBUG : BROWSER_OUTPUT: Values: 119.0 110.0 108.0 117.0 111.0 109.0 116.0 127.0 113.0 108.0 09:27:55 INFO - 2015-12-04 09:27:55,613 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-12-04 09:27:55,613 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.40 Median:143.50 stddev:7.04 (4.9%) stddev-sans-first:7.45 09:27:55 INFO - 2015-12-04 09:27:55,613 DEBUG : BROWSER_OUTPUT: Values: 145.0 141.0 141.0 156.0 144.0 133.0 143.0 140.0 154.0 137.0 09:27:55 INFO - 2015-12-04 09:27:55,613 DEBUG : BROWSER_OUTPUT: 09:27:55 INFO - 2015-12-04 09:27:55,613 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:1.77 (2.8%) stddev-sans-first:1.58 09:27:55 INFO - 2015-12-04 09:27:55,613 DEBUG : BROWSER_OUTPUT: Values: 66.0 66.0 61.0 65.0 62.0 63.0 62.0 62.0 63.0 63.0 09:27:55 INFO - 2015-12-04 09:27:55,613 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:27:55 INFO - 2015-12-04 09:27:55,613 DEBUG : BROWSER_OUTPUT: 09:27:56 INFO - 2015-12-04 09:27:56,364 INFO : Browser exited with error code: 0 09:27:56 INFO - 2015-12-04 09:27:56,419 INFO : Completed test kraken (00:00:58) 09:27:56 INFO - 2015-12-04 09:27:56,419 INFO : Starting test v8_7 09:27:56 INFO - 2015-12-04 09:27:56,419 DEBUG : operating with platform_type : linux_ 09:27:56 INFO - 2015-12-04 09:27:56,419 INFO : Initialising browser for v8_7 test... 09:27:56 INFO - 2015-12-04 09:27:56,426 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNOyuqo/profile http://localhost:53689/getInfo.html 09:28:00 INFO - 2015-12-04 09:28:00,361 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:28:00 INFO - 2015-12-04 09:28:00,361 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:28:00 INFO - 2015-12-04 09:28:00,361 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:28:00 INFO - 2015-12-04 09:28:00,361 DEBUG : BROWSER_OUTPUT: __metrics 09:28:01 INFO - 2015-12-04 09:28:01,332 INFO : Browser initialized. 09:28:01 INFO - 2015-12-04 09:28:01,333 INFO : Running cycle 1/1 for v8_7 test... 09:28:01 INFO - 2015-12-04 09:28:01,333 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpNOyuqo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:28:12 INFO - 2015-12-04 09:28:12,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 133419008 09:28:12 INFO - 2015-12-04 09:28:12,971 DEBUG : BROWSER_OUTPUT: 09:28:34 INFO - 2015-12-04 09:28:34,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53689/tests/v8_7/run.html (next: http://localhost:53689/tests/v8_7/run.html) 09:28:34 INFO - 2015-12-04 09:28:34,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 132939776 09:28:34 INFO - 2015-12-04 09:28:34,587 DEBUG : BROWSER_OUTPUT: 09:28:34 INFO - 2015-12-04 09:28:34,589 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:28:34 INFO - 2015-12-04 09:28:34,589 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:28:34 INFO - 2015-12-04 09:28:34,589 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:28:34 INFO - 2015-12-04 09:28:34,589 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:28:34 INFO - 2015-12-04 09:28:34,589 DEBUG : BROWSER_OUTPUT: |0;Richards;162.99918500407497 09:28:34 INFO - 2015-12-04 09:28:34,589 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;170.35775127768312 09:28:34 INFO - 2015-12-04 09:28:34,589 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.1120448179272 09:28:34 INFO - 2015-12-04 09:28:34,590 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 09:28:34 INFO - 2015-12-04 09:28:34,590 DEBUG : BROWSER_OUTPUT: |4;RayTrace;907.4410163339383 09:28:34 INFO - 2015-12-04 09:28:34,590 DEBUG : BROWSER_OUTPUT: |5;Earley;549.1488193300385 09:28:34 INFO - 2015-12-04 09:28:34,590 DEBUG : BROWSER_OUTPUT: |6;Boyer;10458.333333333334 09:28:34 INFO - 2015-12-04 09:28:34,590 DEBUG : BROWSER_OUTPUT: |7;RegExp;24166.666666666668 09:28:34 INFO - 2015-12-04 09:28:34,591 DEBUG : BROWSER_OUTPUT: |8;Splay;516.795865633075 09:28:34 INFO - 2015-12-04 09:28:34,591 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 09:28:34 INFO - 2015-12-04 09:28:34,591 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:28:34 INFO - 2015-12-04 09:28:34,591 DEBUG : BROWSER_OUTPUT: __startTimestamp1449250114588__endTimestamp 09:28:34 INFO - 2015-12-04 09:28:34,591 DEBUG : BROWSER_OUTPUT: 09:28:34 INFO - 2015-12-04 09:28:34,591 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:28:34 INFO - 2015-12-04 09:28:34,592 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:28:34 INFO - 2015-12-04 09:28:34,592 DEBUG : BROWSER_OUTPUT: 09:28:34 INFO - 2015-12-04 09:28:34,593 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.00 Median:163.00 stddev:0.00 (0.0%) 09:28:34 INFO - 2015-12-04 09:28:34,593 DEBUG : BROWSER_OUTPUT: Values: 163.0 09:28:34 INFO - 2015-12-04 09:28:34,593 DEBUG : BROWSER_OUTPUT: 09:28:34 INFO - 2015-12-04 09:28:34,593 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:170.36 Median:170.36 stddev:0.00 (0.0%) 09:28:34 INFO - 2015-12-04 09:28:34,593 DEBUG : BROWSER_OUTPUT: Values: 170.4 09:28:34 INFO - 2015-12-04 09:28:34,594 DEBUG : BROWSER_OUTPUT: 09:28:34 INFO - 2015-12-04 09:28:34,594 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.11 Median:280.11 stddev:0.00 (0.0%) 09:28:34 INFO - 2015-12-04 09:28:34,594 DEBUG : BROWSER_OUTPUT: Values: 280.1 09:28:34 INFO - 2015-12-04 09:28:34,594 DEBUG : BROWSER_OUTPUT: 09:28:34 INFO - 2015-12-04 09:28:34,594 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 09:28:34 INFO - 2015-12-04 09:28:34,594 DEBUG : BROWSER_OUTPUT: Values: 5030.2 09:28:34 INFO - 2015-12-04 09:28:34,594 DEBUG : BROWSER_OUTPUT: 09:28:34 INFO - 2015-12-04 09:28:34,594 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:907.44 Median:907.44 stddev:0.00 (0.0%) 09:28:34 INFO - 2015-12-04 09:28:34,594 DEBUG : BROWSER_OUTPUT: Values: 907.4 09:28:34 INFO - 2015-12-04 09:28:34,594 DEBUG : BROWSER_OUTPUT: 09:28:34 INFO - 2015-12-04 09:28:34,594 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:549.15 Median:549.15 stddev:0.00 (0.0%) 09:28:34 INFO - 2015-12-04 09:28:34,594 DEBUG : BROWSER_OUTPUT: Values: 549.1 09:28:34 INFO - 2015-12-04 09:28:34,595 DEBUG : BROWSER_OUTPUT: 09:28:34 INFO - 2015-12-04 09:28:34,595 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10458.33 Median:10458.33 stddev:0.00 (0.0%) 09:28:34 INFO - 2015-12-04 09:28:34,595 DEBUG : BROWSER_OUTPUT: Values: 10458.3 09:28:34 INFO - 2015-12-04 09:28:34,595 DEBUG : BROWSER_OUTPUT: 09:28:34 INFO - 2015-12-04 09:28:34,595 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24166.67 Median:24166.67 stddev:0.00 (0.0%) 09:28:34 INFO - 2015-12-04 09:28:34,595 DEBUG : BROWSER_OUTPUT: Values: 24166.7 09:28:34 INFO - 2015-12-04 09:28:34,595 DEBUG : BROWSER_OUTPUT: 09:28:34 INFO - 2015-12-04 09:28:34,595 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:516.80 Median:516.80 stddev:0.00 (0.0%) 09:28:34 INFO - 2015-12-04 09:28:34,596 DEBUG : BROWSER_OUTPUT: Values: 516.8 09:28:34 INFO - 2015-12-04 09:28:34,596 DEBUG : BROWSER_OUTPUT: 09:28:34 INFO - 2015-12-04 09:28:34,596 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 09:28:34 INFO - 2015-12-04 09:28:34,596 DEBUG : BROWSER_OUTPUT: Values: 4830.9 09:28:34 INFO - 2015-12-04 09:28:34,596 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:28:34 INFO - 2015-12-04 09:28:34,596 DEBUG : BROWSER_OUTPUT: 09:28:35 INFO - 2015-12-04 09:28:35,344 INFO : Browser exited with error code: 0 09:28:35 INFO - 2015-12-04 09:28:35,361 INFO : Completed test v8_7 (00:00:38) 09:28:35 INFO - 2015-12-04 09:28:35,660 INFO : Completed test suite (00:20:05) 09:28:35 INFO - 2015-12-04 09:28:35,660 DEBUG : Working with test: dromaeo_css 09:28:35 INFO - 2015-12-04 09:28:35,660 DEBUG : Generating results file: dromaeo_css 09:28:35 INFO - 2015-12-04 09:28:35,661 DEBUG : Working with test: kraken 09:28:35 INFO - 2015-12-04 09:28:35,661 DEBUG : Generating results file: kraken 09:28:35 INFO - 2015-12-04 09:28:35,662 INFO : javascript benchmark 09:28:35 INFO - 2015-12-04 09:28:35,662 DEBUG : Working with test: v8_7 09:28:35 INFO - 2015-12-04 09:28:35,662 DEBUG : Generating results file: v8_7 09:28:35 INFO - 2015-12-04 09:28:35,662 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:28:35 INFO - 2015-12-04 09:28:35,719 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 09:28:35 INFO - 2015-12-04 09:28:35,719 DEBUG : process_Request line: dromaeo_css 7257.71 graph.html#tests=[[72,52,43]] 09:28:35 INFO - 2015-12-04 09:28:35,719 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:28:35 INFO - 2015-12-04 09:28:35,753 DEBUG : process_Request line: kraken 1482.70 graph.html#tests=[[232,52,43]] 09:28:35 INFO - 2015-12-04 09:28:35,753 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:28:35 INFO - 2015-12-04 09:28:35,784 DEBUG : process_Request line: v8_7 23462.39 graph.html#tests=[[230,52,43]] 09:28:35 INFO - 2015-12-04 09:28:35,786 INFO : javascript benchmark 09:28:35 INFO - 2015-12-04 09:28:35,789 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3427.8457469413875, 3438.295149494354, 3451.0, 3460.2041530447996, 3495.58053033636, 5790.276215473066, 5790.942090579093, 5798.246227990356, 5798.246227990366, 5838.211841401415, 5809.82570522885, 5840.744239988401, 5842.912356314659, 5845.240118784563, 5847.064469684851, 5280.603954703403, 5331.466853314676, 5382.730863456831, 5384.300040994684, 5393.1101368274185, 5171.276021357013, 5230.607704422165, 5271.973640131794, 5289.127293996506, 5342.893142137174, 5303.496167864047, 5343.438938911417, 5351.652142610717, 5377.892442151155, 5378.865528361783, 5281.0, 5323.653962492425, 5323.69569455482, 5330.760115794798, 5333.040052790496, 5127.974360128175, 5132.897342053176, 5217.791288348461, 5242.082635538765, 5242.842714718565, 5644.774209031634, 5650.5479561634975, 5687.289088863892, 5689.715514224272, 5701.600887937846, 6334.239891213084, 6366.0, 6375.171227740364, 6375.362463753634, 6378.043293506012, 6140.938590614126, 6194.101855230966, 6230.501559875199, 6350.523710721668, 6363.0, 5893.469587737081, 5960.850978725566, 5962.731677074498, 5969.195117565978, 5983.790567330123, 6191.442770150618, 6399.040143978347, 6429.6463694496315, 6455.7740479083, 6463.741450341934, 6128.142060111588, 6153.0, 6179.134921111048, 6179.69101544921, 6232.439080482778, 6261.342559031327, 6346.428821406095, 6388.329225431356, 6406.5515413920575, 6428.871422571522, 6103.084537319349, 6196.8760624787255, 6352.555321127476, 6379.489640828722, 6388.520860935449, 6176.722047507873, 6280.874382512324, 6309.968450157719, 6314.8421289467215, 6331.303556608769, 4811.0, 4819.180739274332, 4825.445073816486, 4828.95171048285, 4833.927491087637, 4181.707280490397, 4198.076423186955, 4264.189803937242, 4317.633001194934, 4327.069680018811, 5964.582479226413, 6041.365656606081, 6046.3349031606485, 6049.516038716892, 6057.606255593372, 6346.873062538723, 6385.0, 6427.678616069178, 6454.2577603575255, 6457.063725759738, 5874.970625146932, 5933.970330148321, 5960.493358064527, 5995.490383317467, 6071.635701857903, 5445.128779395278, 5448.155535891943, 5457.126859702428, 5457.2359869618285, 5463.562914966793, 6445.2265728112925, 6479.384458476437, 6520.380563846427, 6529.902051469232, 6534.967325163344, 6129.022607377628, 6235.282942461675, 6239.282482514569, 6352.333005034589, 6372.36276372359, 6459.838504037437, 6527.2167339919515, 6531.706073226621, 6531.804045878631, 6574.934250657432, 6066.272047354346, 6291.402316779899, 6300.464460520907, 6306.747730090745, 6306.810795676137, 6242.1261023455845, 6252.874942501216, 6262.2172228471445, 6346.555741098079, 6362.109304697254, 6120.357362476876, 6144.986077297196, 6147.600405973598, 6159.599626024294, 6246.0, 6037.78867739627, 6133.84665383369, 6141.385861413823, 6154.723037463235, 6155.815325540241, 5996.70016499182, 6036.517078633787, 6060.303065147388, 6082.057281121433, 6088.695565221809, 6126.938730612636, 6197.721102550306, 6209.163346613545, 6253.937460625336, 6270.278917924315, 5899.056151015817, 6016.127661489147, 6108.75564977396, 6118.326984031842, 6120.571559990758], "unit": "ms", "name": "dojo.html", "value": 5794.361555719719}, {"lowerIsBetter": false, "replicates": [566.2921348314607, 619.1795870471625, 623.2178615837125, 687.3023880761028, 699.524323460047, 41434.37848432272, 42275.57724422755, 42437.0, 42456.36315455271, 42497.575024249745, 42927.35608965868, 43374.78312608432, 43460.56539434605, 43466.34800477995, 43542.78228608853, 9081.863772043425, 9188.356815022951, 9202.355835091546, 9216.815663686722, 9219.308551858603, 8932.33007524435, 9083.0, 9087.091290870927, 9091.727248182531, 9104.36269461138, 9052.321075919299, 9166.12921772434, 9166.358354915159, 9176.632934682604, 9177.265818734486, 8930.732078037669, 8981.865272020925, 9053.683121090797, 9057.320700947423, 9095.681651142244, 8929.151730585649, 8952.552372381355, 9046.547672616409, 9050.547472626407, 9081.591328390172, 41656.1668766626, 42169.578304217175, 42263.57736422627, 42504.3624345635, 42539.574604253874, 3369.6630336966355, 3434.055634700477, 3491.6857482826413, 3669.669729724311, 4293.635041021517, 30985.380292394027, 31803.840980794947, 31867.6813231867, 31873.0, 31999.360012799847, 3570.893023162828, 3807.695384369244, 3852.460655508231, 3857.633524815138, 3860.8841734748003, 275703.0, 278693.0, 279449.0, 279592.6020369906, 279712.0, 63016.05475917865, 63167.0, 63238.36761632417, 63277.0, 63351.0, 67507.0, 67836.6608166956, 67903.66048169727, 67978.3202167982, 67979.66010170017, 15562.688746225012, 15760.211989400485, 15866.44467443634, 15908.602284942968, 15938.442154524537, 12632.6841828955, 12636.241825490317, 12681.49274029047, 12738.490460381481, 12817.23096614206, 20981.68527472089, 21355.78644213538, 21388.18200452979, 21426.78573214279, 21462.356129316144, 8595.0, 8722.607482663296, 8748.562571871382, 8756.737297881074, 8833.69082082124, 988.802239552078, 989.1641562879355, 1079.3308148947704, 1213.417559571393, 1216.6106845809256, 28770.568441473395, 28807.2798180043, 29005.56491652627, 29239.707602924125, 29349.0, 1070.1438848920832, 1082.8917108289265, 1089.3028461784463, 1124.9381284029457, 1131.9886801131884, 14748.483803067056, 14973.700525989638, 14997.400103995937, 15363.769543456858, 15415.84584154144, 464094.0, 830094.0, 839835.0, 840944.0, 847359.0, 57525.0, 57705.42294577084, 58144.709276453345, 58273.0, 58485.0, 1477.2096928143392, 1488.1443170177192, 1500.0399744163963, 1500.3248538157873, 1514.4093803416677, 29795.553066703582, 30101.39797204, 30596.541051884684, 31139.532907006866, 31293.217669558442, 46567.301490476995, 47361.52638473571, 47403.52596474129, 47422.0, 47471.525284748095, 336850.0, 336873.0, 337498.0, 337939.0, 338687.0, 33246.667533324355, 33280.833595831864, 33650.83174584209, 33789.32421351608, 34140.487892681136, 43237.0, 43457.3481397773, 43589.56410435855, 44409.333859992774, 44759.10481790281, 36838.63161368352, 37486.0, 37767.62232377641, 38214.0, 38282.0, 37602.24795504129, 37902.24195516019, 38156.6184338153, 38650.22699546049, 43942.56057439385, 40236.59763402329, 40772.79613601913, 40850.59149408468, 41014.0, 41069.38395924004, 33036.0, 33755.3248935015, 33782.49326260059, 34058.82970585131, 34130.48804267888, 27200.183994480198, 27730.306742331602, 27869.16392508228, 28050.859745701142, 28153.71846281593], "unit": "ms", "name": "ext.html", "value": 20126.099963631023}, {"lowerIsBetter": false, "replicates": [383.40380707999066, 391.0926650171603, 398.5357059026235, 398.6053806731336, 399.5225705282187, 12303.138780285384, 12847.0, 17924.731129033058, 20012.799872001277, 20059.0, 12837.80743288849, 13373.732525349487, 13552.119112257697, 13565.25391103489, 13682.863171368308, 4864.440589332219, 4958.305837182797, 4981.651284410093, 4982.975085124569, 4986.177280748672, 4831.855044348676, 4918.36061312029, 5017.5484206421415, 5032.320636714034, 5069.645124841262, 4989.077020751154, 4996.350474438318, 4996.77514511846, 5093.26147708582, 5263.578913686915, 5238.869028274305, 5244.292020577231, 5244.842654720326, 5254.133068043807, 5260.736963151846, 4335.761533115678, 4537.001859590885, 4539.0921815636675, 4551.431071116111, 4569.474510431276, 14413.13521188732, 14581.125132492085, 14746.336414861356, 14809.111453312727, 14914.552563423114, 2083.802038806326, 2108.5888251790907, 2110.567333696604, 2125.1499400239873, 2236.507968246983, 10674.519646615921, 10681.83977240342, 10857.837132443019, 10962.835557466644, 11143.888561114367, 1762.7003409420429, 1807.5210069331638, 1835.1191428114446, 1855.2209866266617, 1860.079260765916, 55804.16293755597, 59779.0, 63680.0, 65382.673086634735, 66505.0, 7401.962990185015, 7458.70165193397, 7593.6582853771715, 7624.656890439833, 7705.537667739954, 9361.812763744687, 9381.718548443558, 9419.434833909987, 9424.057594240521, 9428.669996550088, 6093.177421048191, 6096.847578810565, 6181.84545386369, 6224.813255602339, 6255.499560035186, 6288.151099601495, 6292.119103325538, 6378.202724659418, 6404.071409645575, 6433.8713225736155, 3579.749417540799, 3619.3123306571665, 3642.8360723767496, 3656.03115174479, 3706.6664000240107, 1291.341415877909, 1308.6662900960384, 1310.6723319170208, 1311.763882501159, 1351.4323983926774, 493.15177894022224, 547.5209191957038, 568.718484350241, 572.1046562130252, 580.9302883653904, 13136.080474366703, 13282.136661116996, 13372.331383430985, 13495.797563036562, 13534.120282181626, 548.9121740521498, 556.9888602227933, 572.6792995922297, 580.9186713860063, 593.2080672302438, 7213.134423869064, 7300.452466065067, 7304.5982470963545, 7388.593627350439, 7425.108986921604, 425040.0, 426783.0, 437485.0, 645026.0, 645029.0, 73130.63434682899, 77927.0, 77933.0, 79084.60457697675, 83868.0, 593.2880543348, 598.2611474828583, 602.6474512410289, 603.2881200183738, 603.6860832367232, 12025.0, 12286.508539658313, 12305.446254918372, 12329.815052774395, 12454.190477618926, 37809.0, 37838.62161378351, 38220.0, 38928.22143557169, 39379.0, 51724.0, 52018.47981520136, 52438.47561524488, 54282.45717542774, 54407.45592544182, 7436.330730234305, 7498.700051997859, 7558.962205188939, 7567.356774673995, 7579.355754760686, 11075.446227688422, 11760.82358764602, 13110.934445327712, 13229.272390018641, 13346.265955372548, 11665.941670291933, 12002.579909703118, 12099.274043557414, 12142.332171730639, 12250.0, 10172.440515771703, 11007.0, 11142.944285278845, 11149.832752508557, 11177.776444471228, 11205.943970280096, 11287.0, 11487.13846461502, 11538.48076836561, 11573.537058517564, 14081.366338514586, 15334.233288335316, 15525.84474155244, 15697.450589229778, 16186.271617776993, 15926.362945482051, 16261.918690406945, 16512.174391280147, 16539.173041348124, 16745.24646390891], "unit": "ms", "name": "jquery.html", "value": 7720.089564346448}, {"lowerIsBetter": false, "replicates": [1534.831168571457, 1539.3611651164767, 1709.1454272863568, 1767.284249878799, 1830.7070868661012, 8298.460600060991, 8434.0, 8479.618417171234, 8609.569521523914, 8764.386492945496, 8803.95598022009, 8858.291336693064, 8867.201951824334, 8915.108489151082, 8923.955380223106, 2453.3498622864954, 2472.295395812194, 2473.950520989579, 2482.2181012980855, 2497.088562674629, 2491.725910149891, 2520.231329444519, 2532.3669082729316, 2535.2267558394683, 2545.834520756145, 2429.878506074698, 2444.4255599934, 2450.742672019439, 2462.729099799021, 2481.677381940345, 2451.227863223097, 2473.777360037587, 2483.788877945377, 2511.2842839790665, 2514.421683012908, 2480.0, 2487.8880450379775, 2502.4869901670295, 2519.1308998395525, 2524.078711270373, 8589.828203435896, 8621.784455388603, 8624.18070283322, 8669.393142480028, 8694.869576956351, 5251.973740131313, 5330.440303768088, 5337.492938170868, 5339.038972984861, 5346.037713211659, 3439.8452069656923, 3440.587129544446, 3482.0424383294544, 3525.5593050868642, 3543.8050907200095, 1064.9893501064967, 1091.9344839309667, 1093.240198062347, 1130.4065365683, 1151.7351009267832, 11835.112366572455, 11891.04871610269, 11905.523779048914, 11931.0, 11932.343721095336, 4663.906721865612, 4709.058188362273, 4709.811607535728, 4710.8351207707565, 4726.645501587394, 9510.762230944143, 9569.234461243084, 9618.711438656852, 9623.133917947418, 9637.855432168522, 5238.816641417532, 5248.921266181011, 5261.842144735664, 5262.131748261494, 5263.0000299942885, 4837.7097374157665, 4848.636352273594, 4851.611871050308, 4857.247126695368, 4866.926996095061, 3747.306748251582, 3827.3302172119766, 3839.8080095995088, 3860.401637746154, 3865.265599536079, 1079.7894410590018, 1139.1399493382444, 1146.0545050333342, 1168.0772189969998, 1179.2688533109526, 1031.2832581355885, 1104.690686607751, 1104.6962085426571, 1301.1867582760774, 1407.9929600351932, 8041.477303975223, 8058.1538938411795, 8107.0, 8173.509589424653, 8360.58197090143, 1194.1402190422882, 1205.2105870654734, 1205.487667741224, 1206.1135065726685, 1223.5472875036116, 6359.9364006360265, 6412.67936603168, 6412.9679351602945, 6460.095586617877, 6465.644389558525, 10442.321249118782, 10509.421981790922, 10578.312409693346, 10592.258541901992, 10608.045275925204, 10290.794184116276, 10433.5826566938, 10475.266731328733, 10492.055714985689, 10508.842367364496, 8091.0695270043525, 8117.350611951029, 8128.146544612849, 8153.939987801547, 8159.428839981144, 7698.730544430918, 7782.610869456617, 7882.802929926797, 7885.6451459685595, 7907.209279072047, 9135.680251191176, 9347.158755712018, 9361.906380936376, 9420.528973551158, 9428.669996550088, 9434.858477122985, 9557.856632150662, 9595.13643772064, 9653.855192171983, 9681.0, 7200.927990720235, 7237.276272372931, 7312.122545294599, 7312.9396237546325, 7329.157146928172, 8079.555624440713, 8085.555294458862, 8091.757247282591, 8100.959495202486, 8133.552654603817, 7329.340359367469, 7763.340116089969, 7888.881666775118, 7987.281144697005, 7989.201079891965, 7311.597862117635, 7370.557766534025, 7388.778336649909, 7445.627718614156, 7463.776086717407, 7537.321641052332, 7542.321191092828, 7570.091589009354, 7572.621368931642, 7592.924070759443, 6704.195496540447, 6799.626020568916, 6902.827429314308, 6934.341237582422, 6976.267491913276, 7007.7196912122945, 7020.894686579808, 7023.789286321418, 7049.013138160559, 7054.506184567031], "unit": "ms", "name": "mootools.html", "value": 4909.283761168472}, {"lowerIsBetter": false, "replicates": [376.62149539712584, 377.562028047465, 377.99433008504894, 382.1077783375816, 387.54850599052105, 6204.6277223366515, 6241.906371404421, 6276.811695649132, 6291.33940936202, 6311.905321420177, 6059.394060593939, 6085.361037091097, 6140.1096840958035, 6203.906941395871, 6207.4723648489935, 4786.473487916326, 4812.566868981799, 4823.083614113307, 4831.396075490564, 4834.468208497063, 4805.831795887145, 4823.469418363977, 4831.154547954112, 4833.0, 4844.709317440947, 4708.0, 4787.904241915159, 4799.328094066834, 4863.197572400567, 4869.123557759602, 4857.53853383928, 4860.1494738420815, 4864.246041863482, 4872.147374209517, 4877.926831097537, 4324.740515569076, 4326.242907491176, 4328.6753493487795, 4332.718373305725, 4335.046289816235, 5966.642001479925, 6012.398760123952, 6033.185519954794, 6046.3651316612, 6055.061465472859, 5546.417626149237, 5617.988762022835, 5620.887582248332, 5632.211490391349, 5632.324121105453, 6666.0, 6669.866602667968, 6670.7331706731675, 6675.165604299463, 6685.5320127591085, 4633.86098417048, 4667.486576476585, 4674.994876101655, 4678.970626462173, 4682.3210634458155, 6718.193816741973, 6841.828954276083, 6843.623600702009, 6874.484413668944, 6901.344372284675, 4747.762611869462, 4777.8088876445245, 4786.090642777861, 4793.736344501086, 4798.328234047236, 4848.17581011229, 4850.029994001214, 4850.805967761321, 4860.756962151878, 4865.70805751656, 5547.72261386929, 5549.750261238254, 5555.861103472445, 5557.833265002057, 5563.332400111932, 6522.706478208492, 6604.405603495612, 6637.070810086591, 6648.268690444047, 6669.333066693389, 1733.8699597530235, 1738.782652168479, 1756.9912150439422, 1759.24352528414, 1766.0816375484933, 1183.6863231243726, 1187.8099504079478, 1192.821076838481, 1198.0894520164738, 1201.5854530187246, 6285.654289014148, 6297.811065668037, 6304.275008374096, 6304.621722696653, 6305.905411418832, 6695.899561506581, 6735.0, 6743.527953043338, 6754.223264324665, 6756.662166891636, 6287.0, 6320.71556779946, 6322.430981211713, 6366.649834259068, 6369.01280301554, 3807.6763475104926, 3830.7893065881644, 3840.558335791364, 3841.654251117413, 3844.461775351453, 7083.433325333961, 7087.043249161297, 7090.432765378758, 7101.822454438577, 7114.466415018895, 6870.690818913161, 6990.440764738809, 7008.509404341749, 7034.80408330585, 7037.0, 7113.0, 7122.323379278961, 7130.03744494497, 7134.215236324, 7148.606826624586, 6929.0, 6930.3762661360715, 6954.860902782018, 6968.477364197604, 6982.615956122462, 6796.796096117125, 6861.965690171517, 6878.0, 6894.0, 6903.309669033057, 7062.540934839219, 7140.6072666003865, 7156.248593897566, 7170.032045673767, 7183.8563228736175, 4810.63920205979, 4836.830710925101, 4845.0, 4847.684900481458, 4852.56326930578, 6829.863402732017, 6983.790486285419, 6987.371136597731, 7001.544899581511, 7011.193712722898, 6749.0, 6751.358620931003, 6754.696038678369, 6764.8985265222045, 6777.610589829172, 6745.9662701686175, 6751.729930802713, 6754.696038678173, 6761.256261811295, 6771.458283337222, 6569.24453687832, 6658.267590565131, 6691.330866913269, 6696.7656132035145, 6710.66446677674, 6710.698018589078, 6740.258571557027, 6748.831279218059, 6752.493562982698, 6755.493337999768, 6553.115329430657, 6633.900491492728, 6634.635095069818, 6636.867262654623, 6658.067870498231], "unit": "ms", "name": "prototype.html", "value": 5076.768187459223}, {"lowerIsBetter": false, "replicates": [731.997163885477, 768.5696010234269, 876.5573385440351, 889.0575989451182, 916.964334237452, 14994.850051499481, 15418.537443876701, 15440.382384704611, 15534.611634709137, 15568.68862622747, 14182.929085354584, 14234.430622775102, 14265.1440913545, 14294.213818239992, 14363.210023448706, 874.117141686896, 885.8095509465463, 886.5921676029035, 890.7372325164059, 893.5041052216018, 881.5460038080394, 883.6995421556669, 888.0409158109227, 893.7274131389923, 894.8523493623577, 929.7861491856877, 934.5700977550301, 936.1106948399014, 936.2650319499195, 938.1087966431883, 923.007766650853, 923.3305853256369, 926.3422969691527, 926.6432423516927, 927.096081320707, 673.0778832998823, 675.598019178588, 676.681959479044, 677.3632785181962, 679.3614002837317, 14838.925805371013, 15013.699726005529, 15016.474423395239, 15017.774733379008, 15023.02350347224, 11108.666739997812, 11348.262362946381, 11384.487698053608, 11458.828117578243, 11703.765924681544, 10869.45652717361, 11072.28030178044, 11244.831327530093, 11247.83128253077, 11285.548578056867, 3500.0, 3517.8416971236356, 3519.1202199450136, 3525.5240542526685, 3526.9118272043147, 48883.0, 49144.75427622839, 49518.0, 50063.2490512639, 50118.0, 8246.134155913544, 8290.336773058141, 8372.623231954454, 8374.958125209336, 8397.6221070052, 13862.514811981733, 13867.4453021878, 13886.375113119933, 13923.86076139246, 13931.930340348234, 7162.212156662763, 7190.532615379983, 7305.525140865827, 7305.853882922312, 7430.665620047111, 4253.21315556623, 4273.380359847867, 4296.0978194578865, 4344.304911214191, 4344.85626039444, 2987.865546050433, 3008.473517134493, 3024.652165001009, 3024.894128705485, 3025.788194826385, 467.525461656419, 470.06457150270717, 478.7797613098014, 478.8754923719858, 481.76634332348783, 554.978838936359, 616.9660668663176, 618.9938100619026, 626.8622450252776, 704.4927652090487, 7639.847203055908, 7693.230676932262, 7698.0, 7792.688292468351, 7865.252800983897, 664.9335066493312, 702.3924305475726, 718.4252597921642, 720.6144712578745, 738.7045181927272, 4293.184294984006, 4348.0, 4447.666425018137, 4493.977530112328, 4500.752458614807, 62876.68561657162, 63421.36578634154, 64222.0, 64417.35582644113, 64928.35071649317, 58540.0, 58560.0, 59240.40759592435, 59437.0, 60421.69789151026, 53600.73199633977, 54257.0, 54279.0, 54499.0, 54816.72591637016, 8951.910480895107, 8999.955000224956, 9143.771405714644, 9298.116678915492, 9335.299852510952, 40558.18883622252, 41187.588124119575, 41527.961800954006, 41945.37081943712, 42130.578694212665, 47237.0, 51061.744691276304, 53092.20361694501, 53337.466625334804, 54086.72956635192, 8391.874121888055, 8429.831403372022, 8506.0, 8538.402311838112, 8547.487150770974, 12862.549810756578, 13764.65588360299, 14099.436022558983, 14328.928355358157, 14385.136891786107, 11509.712257193638, 11695.649130526097, 11964.222325549159, 11974.46114924813, 12506.062045346818, 12446.377681115728, 12489.31308778026, 12753.04749373115, 12755.681107972376, 13088.934555327163, 11766.647000589654, 11825.763484730085, 11943.880561194625, 11999.100067494799, 12310.630681079581, 9965.202783777426, 10218.131458826083, 10330.741731456774, 10546.472676366304, 10700.785984280426, 9725.0, 9735.70792876215, 9795.559199835881, 9866.753331166778, 10443.791124177626], "unit": "ms", "name": "yui.html", "value": 6512.822863745855}], "name": "dromaeo_css", "value": 7257.707379976504}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 104.0, 111.0, 108.0, 109.0, 118.0, 108.0, 108.0, 109.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [154.0, 121.0, 160.0, 166.0, 124.0, 146.0, 156.0, 122.0, 163.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.5}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 163.0, 161.0, 162.0, 160.0, 160.0, 162.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 154.0, 72.0, 72.0, 72.0, 71.0, 162.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 88.5}, {"lowerIsBetter": true, "replicates": [91.0, 89.0, 131.0, 90.0, 89.0, 90.0, 133.0, 89.0, 91.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 102.7}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 111.0, 111.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 147.0, 148.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [62.0, 58.0, 61.0, 59.0, 61.0, 61.0, 60.0, 65.0, 56.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 60.0}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 61.0}, {"lowerIsBetter": true, "replicates": [90.0, 80.0, 83.0, 81.0, 82.0, 81.0, 81.0, 87.0, 83.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [119.0, 110.0, 108.0, 117.0, 111.0, 109.0, 116.0, 127.0, 113.0, 108.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 113.8}, {"lowerIsBetter": true, "replicates": [145.0, 141.0, 141.0, 156.0, 144.0, 133.0, 143.0, 140.0, 154.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.4}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 61.0, 65.0, 62.0, 63.0, 62.0, 62.0, 63.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.3}], "name": "kraken", "value": 1482.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.99918500407497], "unit": "score", "name": "Richards", "value": 216.57777000000004}, {"lowerIsBetter": false, "replicates": [170.35775127768312], "unit": "score", "name": "DeltaBlue", "value": 388.1126600000002}, {"lowerIsBetter": false, "replicates": [280.1120448179272], "unit": "score", "name": "Encrypt", "value": 950.2661699999999}, {"lowerIsBetter": false, "replicates": [5030.150753768844], "unit": "score", "name": "Decrypt", "value": 52.91710189810189}, {"lowerIsBetter": false, "replicates": [907.4410163339383], "unit": "score", "name": "RayTrace", "value": 815.4678780000004}, {"lowerIsBetter": false, "replicates": [549.1488193300385], "unit": "score", "name": "Earley", "value": 1213.6291230000002}, {"lowerIsBetter": false, "replicates": [10458.333333333334], "unit": "score", "name": "Boyer", "value": 63.725545816733074}, {"lowerIsBetter": false, "replicates": [24166.666666666668], "unit": "score", "name": "RegExp", "value": 37.69593103448274}, {"lowerIsBetter": false, "replicates": [516.795865633075], "unit": "score", "name": "Splay", "value": 157.68508499999996}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 23462.393918634476}]} 09:28:35 INFO - RETURN: dromaeo_css: 7257.71 09:28:35 INFO - RETURN: kraken: 1482.70 09:28:35 INFO - RETURN: v8_7: 23462.39 09:28:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23462.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1482.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7257.71"}}} 09:28:35 INFO - Return code: 0 09:28:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 09:28:35 INFO - # TBPL SUCCESS # 09:28:35 INFO - Running post-action listener: _resource_record_post_action 09:28:35 INFO - Running post-run listener: _resource_record_post_run 09:28:37 INFO - Total resource usage - Wall time: 1221s; CPU: 13.0%; Read bytes: 323584; Write bytes: 508743680; Read time: 128; Write time: 500228 09:28:37 INFO - install - Wall time: 14s; CPU: 15.0%; Read bytes: 0; Write bytes: 244420608; Read time: 0; Write time: 312616 09:28:37 INFO - run-tests - Wall time: 1207s; CPU: 13.0%; Read bytes: 323584; Write bytes: 264323072; Read time: 128; Write time: 187612 09:28:37 INFO - Running post-run listener: _upload_blobber_files 09:28:37 INFO - Blob upload gear active. 09:28:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:28:37 INFO - Copying logs to upload dir... 09:28:37 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1260.598483 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-12-04 09:28:37.018371) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 09:28:37.021983) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009943 build_url: 'https://queue.taskcluster.net/v1/task/btJZbS2eT4yRVSorKLlC-Q/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 09:28:37.074227) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 09:28:37.074641) ========= 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=fdc9337702648c539b2c5dbe000001aa-1449248804.591322-197369989 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 09:28:37.125062) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 09:28:37.125423) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 09:28:37.125853) ========= ========= Total master_lag: 0.18 =========