builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1453749727.1 results: success (0) buildid: 20160125032407 builduid: 84a569e400f549d78ae6c3dedf0c2ad7 revision: 3bfa5bc61b626761d487b45c170b115259f69d6b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:07.104720) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:07.105170) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:07.105478) ========= 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=82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006233 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:07.128258) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:07.128599) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:07.142532) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:07.143086) ========= 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=82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004594 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:07.193283) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:07.193597) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:07.193942) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:07.194211) ========= 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=82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 11:22:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-01-25 11:22:07 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167366 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:07.373907) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:07.374213) ========= 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=82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020809 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:07.424570) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:07.424916) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3bfa5bc61b626761d487b45c170b115259f69d6b --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 3bfa5bc61b626761d487b45c170b115259f69d6b --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=82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 11:22:07,808 truncating revision to first 12 chars 2016-01-25 11:22:07,808 Setting DEBUG logging. 2016-01-25 11:22:07,808 attempt 1/10 2016-01-25 11:22:07,808 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3bfa5bc61b62?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 11:22:08,059 unpacking tar archive at: mozilla-aurora-3bfa5bc61b62/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550460 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:07.991234) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:07.992001) ========= echo 3bfa5bc61b626761d487b45c170b115259f69d6b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3bfa5bc61b626761d487b45c170b115259f69d6b'] 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=82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 3bfa5bc61b626761d487b45c170b115259f69d6b program finished with exit code 0 elapsedTime=0.004674 script_repo_revision: '3bfa5bc61b626761d487b45c170b115259f69d6b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:08.048548) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:08.049296) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 11:22:08.060098) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-01-25 11:22:08.060406) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --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', '--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=82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:22:08 INFO - MultiFileLogger online at 20160125 11:22:08 in /builds/slave/test-pgo 11:22:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 11:22:08 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 11:22:08 INFO - {'append_to_log': False, 11:22:08 INFO - 'base_work_dir': '/builds/slave/test-pgo', 11:22:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:22:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 11:22:08 INFO - 'branch': 'Mozilla-Aurora', 11:22:08 INFO - 'buildbot_json_path': 'buildprops.json', 11:22:08 INFO - 'config_files': ('talos/linux_config.py',), 11:22:08 INFO - 'default_actions': ('clobber', 11:22:08 INFO - 'read-buildbot-config', 11:22:08 INFO - 'download-and-extract', 11:22:08 INFO - 'populate-webroot', 11:22:08 INFO - 'create-virtualenv', 11:22:08 INFO - 'install', 11:22:08 INFO - 'run-tests'), 11:22:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:22:08 INFO - 'download_minidump_stackwalk': True, 11:22:08 INFO - 'download_symbols': 'ondemand', 11:22:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:22:08 INFO - 'tooltool.py': '/tools/tooltool.py', 11:22:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:22:08 INFO - '/tools/misc-python/virtualenv.py')}, 11:22:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:22:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:22:08 INFO - 'installer_path': 'installer.exe', 11:22:08 INFO - 'log_level': 'info', 11:22:08 INFO - 'log_name': 'talos', 11:22:08 INFO - 'log_to_console': True, 11:22:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:22:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:22:08 INFO - 'opt_config_files': (), 11:22:08 INFO - 'pip_index': False, 11:22:08 INFO - 'sps_profile': False, 11:22:08 INFO - 'sps_profile_interval': 0, 11:22:08 INFO - 'suite': 'dromaeojs-e10s', 11:22:08 INFO - 'system_bits': '32', 11:22:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:22:08 INFO - 'title': 'talos-linux64-ix-055', 11:22:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:22:08 INFO - 'use_talos_json': True, 11:22:08 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 11:22:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:22:08 INFO - 'work_dir': 'build'} 11:22:08 INFO - ##### 11:22:08 INFO - ##### Running clobber step. 11:22:08 INFO - ##### 11:22:08 INFO - Running pre-action listener: _resource_record_pre_action 11:22:08 INFO - Running main action method: clobber 11:22:08 INFO - rmtree: /builds/slave/test-pgo/build 11:22:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 11:22:09 INFO - Running post-action listener: _resource_record_post_action 11:22:09 INFO - ##### 11:22:09 INFO - ##### Running read-buildbot-config step. 11:22:09 INFO - ##### 11:22:09 INFO - Running pre-action listener: _resource_record_pre_action 11:22:09 INFO - Running main action method: read_buildbot_config 11:22:09 INFO - Using buildbot properties: 11:22:09 INFO - { 11:22:09 INFO - "properties": { 11:22:09 INFO - "buildnumber": 91, 11:22:09 INFO - "product": "firefox", 11:22:09 INFO - "script_repo_revision": "production", 11:22:09 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 11:22:09 INFO - "repository": "", 11:22:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 11:22:09 INFO - "buildid": "20160125032407", 11:22:09 INFO - "slavename": "talos-linux64-ix-055", 11:22:09 INFO - "pgo_build": "True", 11:22:09 INFO - "basedir": "/builds/slave/test-pgo", 11:22:09 INFO - "project": "", 11:22:09 INFO - "platform": "ubuntu64_hw", 11:22:09 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:22:09 INFO - "slavebuilddir": "test", 11:22:09 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:22:09 INFO - "branch": "mozilla-aurora", 11:22:09 INFO - "repo_path": "releases/mozilla-aurora", 11:22:09 INFO - "stage_platform": "linux64-pgo", 11:22:09 INFO - "builduid": "84a569e400f549d78ae6c3dedf0c2ad7", 11:22:09 INFO - "revision": "3bfa5bc61b626761d487b45c170b115259f69d6b" 11:22:09 INFO - }, 11:22:09 INFO - "sourcestamp": { 11:22:09 INFO - "repository": "", 11:22:09 INFO - "hasPatch": false, 11:22:09 INFO - "project": "", 11:22:09 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:22:09 INFO - "changes": [ 11:22:09 INFO - { 11:22:09 INFO - "category": null, 11:22:09 INFO - "files": [ 11:22:09 INFO - { 11:22:09 INFO - "url": null, 11:22:09 INFO - "name": "https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 11:22:09 INFO - } 11:22:09 INFO - ], 11:22:09 INFO - "repository": "", 11:22:09 INFO - "rev": "3bfa5bc61b626761d487b45c170b115259f69d6b", 11:22:09 INFO - "who": "cbook@mozilla.com", 11:22:09 INFO - "when": 1453730728, 11:22:09 INFO - "number": 7510949, 11:22:09 INFO - "comments": "Bug 1234675 - Ability to disable e10s for users with addons. r=Mossop, a=sylvestre", 11:22:09 INFO - "project": "", 11:22:09 INFO - "at": "Mon 25 Jan 2016 06:05:28", 11:22:09 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 11:22:09 INFO - "revlink": "", 11:22:09 INFO - "properties": [ 11:22:09 INFO - [ 11:22:09 INFO - "buildid", 11:22:09 INFO - "20160125032407", 11:22:09 INFO - "Change" 11:22:09 INFO - ], 11:22:09 INFO - [ 11:22:09 INFO - "builduid", 11:22:09 INFO - "84a569e400f549d78ae6c3dedf0c2ad7", 11:22:09 INFO - "Change" 11:22:09 INFO - ], 11:22:09 INFO - [ 11:22:09 INFO - "pgo_build", 11:22:09 INFO - "True", 11:22:09 INFO - "Change" 11:22:09 INFO - ] 11:22:09 INFO - ], 11:22:09 INFO - "revision": "3bfa5bc61b626761d487b45c170b115259f69d6b" 11:22:09 INFO - } 11:22:09 INFO - ], 11:22:09 INFO - "revision": "3bfa5bc61b626761d487b45c170b115259f69d6b" 11:22:09 INFO - } 11:22:09 INFO - } 11:22:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 11:22:09 INFO - Running post-action listener: _resource_record_post_action 11:22:09 INFO - ##### 11:22:09 INFO - ##### Running download-and-extract step. 11:22:09 INFO - ##### 11:22:09 INFO - Running pre-action listener: _resource_record_pre_action 11:22:09 INFO - Running main action method: download_and_extract 11:22:09 INFO - mkdir: /builds/slave/test-pgo/build/tests 11:22: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')]} 11:22:09 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:22:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json 11:22:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json 11:22:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 11:22:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 11:22:09 INFO - Downloaded 1302 bytes. 11:22:09 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 11:22:09 INFO - Using the following test package requirements: 11:22:09 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:22:09 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:09 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:22:09 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:09 INFO - u'jsshell-linux-x86_64.zip'], 11:22:09 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:09 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:22:09 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:22:09 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:09 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:22:09 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:09 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:22:09 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:09 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:22:09 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 11:22:09 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:09 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:22:09 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:22: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')]} 11:22:09 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:22:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:22:10 INFO - Downloaded 21579043 bytes. 11:22:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:22:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:10 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:22:11 INFO - Return code: 0 11:22:11 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:22: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')]} 11:22:11 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:22:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:22:12 INFO - Downloaded 21579043 bytes. 11:22:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 11:22:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 11:22:12 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:22:14 INFO - Return code: 0 11:22:14 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')]} 11:22:14 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:22:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:22:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:22:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:22:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:22:15 INFO - Downloaded 11132038 bytes. 11:22:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 11:22:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 11:22:15 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:22:15 INFO - Return code: 0 11:22:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:15 INFO - https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:22:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:22:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:22:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:22:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:22:16 INFO - Downloaded 58070235 bytes. 11:22:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:22:16 INFO - mkdir: /builds/slave/test-pgo/properties 11:22:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 11:22:16 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 11:22:16 INFO - Contents: 11:22:16 INFO - build_url:https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 11:22:16 INFO - Running post-action listener: _resource_record_post_action 11:22:16 INFO - Running post-action listener: set_extra_try_arguments 11:22:16 INFO - ##### 11:22:16 INFO - ##### Running populate-webroot step. 11:22:16 INFO - ##### 11:22:16 INFO - Running pre-action listener: _resource_record_pre_action 11:22:16 INFO - Running main action method: populate_webroot 11:22:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:22:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:22:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:22:16 INFO - '--tppagecycles', 11:22:16 INFO - '7'], 11:22:16 INFO - 'tests': ['tsvgm']}}, 11:22:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:22:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:22:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:22:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:22:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'tests': ['damp', 'tps']}, 11:22:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['damp', 'tps']}, 11:22:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:22:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:22:16 INFO - 'other': {'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore']}, 11:22:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore']}, 11:22:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore']}, 11:22:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore']}, 11:22:16 INFO - 'other_l64': {'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore']}, 11:22:16 INFO - 'other_nol64': {'tests': ['a11yr', 11:22:16 INFO - 'ts_paint', 11:22:16 INFO - 'tpaint', 11:22:16 INFO - 'sessionrestore', 11:22:16 INFO - 'sessionrestore_no_auto_restore']}, 11:22:16 INFO - 'svgr': {'tests': ['tsvgx', 11:22:16 INFO - 'tsvgr_opacity', 11:22:16 INFO - 'tart', 11:22:16 INFO - 'tscrollx', 11:22:16 INFO - 'cart']}, 11:22:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['tsvgx', 11:22:16 INFO - 'tsvgr_opacity', 11:22:16 INFO - 'tart', 11:22:16 INFO - 'tscrollx', 11:22:16 INFO - 'cart']}, 11:22:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'tests': ['tp5o']}, 11:22:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'talos_options': ['--e10s'], 11:22:16 INFO - 'tests': ['tp5o']}, 11:22:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'talos_options': ['--xperf_path', 11:22:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:16 INFO - 'tests': ['tp5n']}, 11:22:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:16 INFO - 'talos_options': ['--e10s', 11:22:16 INFO - '--xperf_path', 11:22:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:16 INFO - 'tests': ['tp5n']}}, 11:22:16 INFO - 'talos.zip': {'path': '', 11:22:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:22:16 INFO - Running post-action listener: _resource_record_post_action 11:22:16 INFO - ##### 11:22:16 INFO - ##### Running create-virtualenv step. 11:22:16 INFO - ##### 11:22:16 INFO - Running pre-action listener: _resource_record_pre_action 11:22:16 INFO - Running main action method: create_virtualenv 11:22:16 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 11:22:16 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 11:22:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 11:22:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:22:16 INFO - Using real prefix '/usr' 11:22:16 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 11:22:17 INFO - Installing distribute.............................................................................................................................................................................................done. 11:22:19 INFO - Installing pip.................done. 11:22:19 INFO - Return code: 0 11:22:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 11:22:19 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')]} 11:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:19 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')]} 11:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb018dedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257da50>, '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 0x24e9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e99e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', '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 11:22:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:22:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:22:19 INFO - Using env: {'DISPLAY': ':0', 11:22:19 INFO - 'HOME': '/home/cltbld', 11:22:19 INFO - 'LANG': 'en_US.UTF-8', 11:22:19 INFO - 'LANGUAGE': 'en_US:en', 11:22:19 INFO - 'LOGNAME': 'cltbld', 11:22:19 INFO - 'MAIL': '/var/mail/cltbld', 11:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:19 INFO - 'MOZ_NO_REMOTE': '1', 11:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:19 INFO - 'NO_EM_RESTART': '1', 11:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:19 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:19 INFO - 'SHELL': '/bin/bash', 11:22:19 INFO - 'SHLVL': '1', 11:22:19 INFO - 'TERM': 'linux', 11:22:19 INFO - 'TMOUT': '86400', 11:22:19 INFO - 'USER': 'cltbld', 11:22:19 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', 11:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:19 INFO - '_': '/tools/buildbot/bin/python'} 11:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:19 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 11:22:19 INFO - Cleaning up... 11:22:19 INFO - Return code: 0 11:22:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 11:22:19 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')]} 11:22:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:19 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')]} 11:22:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb018dedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257da50>, '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 0x24e9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e99e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', '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 11:22:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:22:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:22:19 INFO - Using env: {'DISPLAY': ':0', 11:22:19 INFO - 'HOME': '/home/cltbld', 11:22:19 INFO - 'LANG': 'en_US.UTF-8', 11:22:19 INFO - 'LANGUAGE': 'en_US:en', 11:22:19 INFO - 'LOGNAME': 'cltbld', 11:22:19 INFO - 'MAIL': '/var/mail/cltbld', 11:22:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:19 INFO - 'MOZ_NO_REMOTE': '1', 11:22:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:19 INFO - 'NO_EM_RESTART': '1', 11:22:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:19 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:19 INFO - 'SHELL': '/bin/bash', 11:22:19 INFO - 'SHLVL': '1', 11:22:19 INFO - 'TERM': 'linux', 11:22:19 INFO - 'TMOUT': '86400', 11:22:19 INFO - 'USER': 'cltbld', 11:22:19 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', 11:22:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:19 INFO - '_': '/tools/buildbot/bin/python'} 11:22:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:19 INFO - Downloading/unpacking psutil>=0.7.1 11:22:19 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 11:22:19 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 11:22:19 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 11:22:19 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 11:22:19 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 11:22:19 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 11:22:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 11:22:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:21 INFO - Installing collected packages: psutil 11:22:21 INFO - Running setup.py install for psutil 11:22:21 INFO - building 'psutil._psutil_linux' extension 11:22:21 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 11:22:22 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 11:22:22 INFO - building 'psutil._psutil_posix' extension 11:22:22 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 11:22:22 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 11:22:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:22 INFO - Successfully installed psutil 11:22:22 INFO - Cleaning up... 11:22:22 INFO - Return code: 0 11:22:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 11:22:22 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')]} 11:22:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:22 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')]} 11:22:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:22 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb018dedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257da50>, '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 0x24e9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e99e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', '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 11:22:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:22:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:22:22 INFO - Using env: {'DISPLAY': ':0', 11:22:22 INFO - 'HOME': '/home/cltbld', 11:22:22 INFO - 'LANG': 'en_US.UTF-8', 11:22:22 INFO - 'LANGUAGE': 'en_US:en', 11:22:22 INFO - 'LOGNAME': 'cltbld', 11:22:22 INFO - 'MAIL': '/var/mail/cltbld', 11:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:22 INFO - 'MOZ_NO_REMOTE': '1', 11:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:22 INFO - 'NO_EM_RESTART': '1', 11:22:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:22 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:22 INFO - 'SHELL': '/bin/bash', 11:22:22 INFO - 'SHLVL': '1', 11:22:22 INFO - 'TERM': 'linux', 11:22:22 INFO - 'TMOUT': '86400', 11:22:22 INFO - 'USER': 'cltbld', 11:22:22 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', 11:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:22 INFO - '_': '/tools/buildbot/bin/python'} 11:22:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:22:22 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 11:22:22 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 11:22:22 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 11:22:22 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 11:22:22 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 11:22:22 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 11:22:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:22:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:22:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:22:25 INFO - Installing collected packages: mozsystemmonitor 11:22:25 INFO - Running setup.py install for mozsystemmonitor 11:22:25 INFO - Successfully installed mozsystemmonitor 11:22:25 INFO - Cleaning up... 11:22:25 INFO - Return code: 0 11:22:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 11:22:25 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')]} 11:22:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:25 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')]} 11:22:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:25 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb018dedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257da50>, '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 0x24e9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e99e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', '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 11:22:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:22:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:22:25 INFO - Using env: {'DISPLAY': ':0', 11:22:25 INFO - 'HOME': '/home/cltbld', 11:22:25 INFO - 'LANG': 'en_US.UTF-8', 11:22:25 INFO - 'LANGUAGE': 'en_US:en', 11:22:25 INFO - 'LOGNAME': 'cltbld', 11:22:25 INFO - 'MAIL': '/var/mail/cltbld', 11:22:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:25 INFO - 'MOZ_NO_REMOTE': '1', 11:22:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:25 INFO - 'NO_EM_RESTART': '1', 11:22:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:25 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:25 INFO - 'SHELL': '/bin/bash', 11:22:25 INFO - 'SHLVL': '1', 11:22:25 INFO - 'TERM': 'linux', 11:22:25 INFO - 'TMOUT': '86400', 11:22:25 INFO - 'USER': 'cltbld', 11:22:25 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', 11:22:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:25 INFO - '_': '/tools/buildbot/bin/python'} 11:22:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:25 INFO - Downloading/unpacking blobuploader==1.2.4 11:22:25 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 11:22:25 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 11:22:25 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 11:22:25 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 11:22:25 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 11:22:25 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 11:22:27 INFO - Downloading blobuploader-1.2.4.tar.gz 11:22:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:22:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:22:27 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 11:22:27 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 11:22:27 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 11:22:27 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 11:22:27 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 11:22:27 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 11:22:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 11:22:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:22:27 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 11:22:27 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 11:22:27 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 11:22:27 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 11:22:27 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 11:22:27 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 11:22:28 INFO - Downloading docopt-0.6.1.tar.gz 11:22:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 11:22:28 INFO - Installing collected packages: blobuploader, requests, docopt 11:22:28 INFO - Running setup.py install for blobuploader 11:22:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:22:28 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 11:22:28 INFO - Running setup.py install for requests 11:22:28 INFO - Running setup.py install for docopt 11:22:28 INFO - Successfully installed blobuploader requests docopt 11:22:28 INFO - Cleaning up... 11:22:28 INFO - Return code: 0 11:22:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:28 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fb018dedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257da50>, '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 0x24e9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e99e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', '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 11:22:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 11:22:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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 11:22:28 INFO - Using env: {'DISPLAY': ':0', 11:22:28 INFO - 'HOME': '/home/cltbld', 11:22:28 INFO - 'LANG': 'en_US.UTF-8', 11:22:28 INFO - 'LANGUAGE': 'en_US:en', 11:22:28 INFO - 'LOGNAME': 'cltbld', 11:22:28 INFO - 'MAIL': '/var/mail/cltbld', 11:22:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:28 INFO - 'MOZ_NO_REMOTE': '1', 11:22:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:28 INFO - 'NO_EM_RESTART': '1', 11:22:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:28 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:28 INFO - 'SHELL': '/bin/bash', 11:22:28 INFO - 'SHLVL': '1', 11:22:28 INFO - 'TERM': 'linux', 11:22:28 INFO - 'TMOUT': '86400', 11:22:28 INFO - 'USER': 'cltbld', 11:22:28 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', 11:22:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:28 INFO - '_': '/tools/buildbot/bin/python'} 11:22:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:28 INFO - Running setup.py (path:/tmp/pip-uv5Rxh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:29 INFO - Running setup.py (path:/tmp/pip-Cs6HFO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:29 INFO - Running setup.py (path:/tmp/pip-KzgNyt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:29 INFO - Running setup.py (path:/tmp/pip-wNjU8K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:29 INFO - Running setup.py (path:/tmp/pip-1oQ5ff-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:29 INFO - Running setup.py (path:/tmp/pip-qI4g2K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:29 INFO - Running setup.py (path:/tmp/pip-8Z22jN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:29 INFO - Running setup.py (path:/tmp/pip-liORRK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:29 INFO - Running setup.py (path:/tmp/pip-ozjbby-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:29 INFO - Running setup.py (path:/tmp/pip-fUfd_w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:29 INFO - Running setup.py (path:/tmp/pip-x246a7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:29 INFO - Running setup.py (path:/tmp/pip-fgo3nk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:29 INFO - Running setup.py (path:/tmp/pip-TXspv3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:29 INFO - Running setup.py (path:/tmp/pip-QnugZ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:30 INFO - Running setup.py (path:/tmp/pip-GnUSEB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:30 INFO - Running setup.py (path:/tmp/pip-jVygMK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:30 INFO - Running setup.py (path:/tmp/pip-WNtsdF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:22:30 INFO - Running setup.py install for manifestparser 11:22:30 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Running setup.py install for mozcrash 11:22:30 INFO - Running setup.py install for mozdebug 11:22:30 INFO - Running setup.py install for mozdevice 11:22:30 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Running setup.py install for mozfile 11:22:30 INFO - Running setup.py install for mozhttpd 11:22:30 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Running setup.py install for mozinfo 11:22:30 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 11:22:30 INFO - Running setup.py install for mozInstall 11:22:31 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 11:22:31 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 11:22:31 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 11:22:31 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 11:22:31 INFO - Running setup.py install for mozleak 11:22:31 INFO - Running setup.py install for mozlog 11:22:31 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 11:22:31 INFO - Running setup.py install for moznetwork 11:22:31 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 11:22:31 INFO - Running setup.py install for mozprocess 11:22:31 INFO - Running setup.py install for mozprofile 11:22:31 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 11:22:31 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 11:22:31 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 11:22:31 INFO - Running setup.py install for mozrunner 11:22:31 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 11:22:31 INFO - Running setup.py install for mozscreenshot 11:22:31 INFO - Running setup.py install for moztest 11:22:31 INFO - Running setup.py install for mozversion 11:22:31 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 11:22:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:22:31 INFO - Cleaning up... 11:22:31 INFO - Return code: 0 11:22:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:22:31 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')]} 11:22:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:31 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')]} 11:22:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb018dedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257da50>, '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 0x24e9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e99e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', '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 11:22:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:22:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:22:31 INFO - Using env: {'DISPLAY': ':0', 11:22:31 INFO - 'HOME': '/home/cltbld', 11:22:31 INFO - 'LANG': 'en_US.UTF-8', 11:22:31 INFO - 'LANGUAGE': 'en_US:en', 11:22:31 INFO - 'LOGNAME': 'cltbld', 11:22:31 INFO - 'MAIL': '/var/mail/cltbld', 11:22:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:31 INFO - 'MOZ_NO_REMOTE': '1', 11:22:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:31 INFO - 'NO_EM_RESTART': '1', 11:22:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:31 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:31 INFO - 'SHELL': '/bin/bash', 11:22:31 INFO - 'SHLVL': '1', 11:22:31 INFO - 'TERM': 'linux', 11:22:31 INFO - 'TMOUT': '86400', 11:22:31 INFO - 'USER': 'cltbld', 11:22:31 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', 11:22:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:31 INFO - '_': '/tools/buildbot/bin/python'} 11:22:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:32 INFO - Running setup.py (path:/tmp/pip-hmUnHr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:32 INFO - Running setup.py (path:/tmp/pip-VJmeXx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:32 INFO - Running setup.py (path:/tmp/pip-irt4c2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:32 INFO - Running setup.py (path:/tmp/pip-8BfiRM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 11:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:32 INFO - Running setup.py (path:/tmp/pip-IZfRjL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:32 INFO - Running setup.py (path:/tmp/pip-sxWYJE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:32 INFO - Running setup.py (path:/tmp/pip-0dljtJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 11:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:32 INFO - Running setup.py (path:/tmp/pip-vzT1B1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:32 INFO - Running setup.py (path:/tmp/pip-ysa1ch-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:32 INFO - Running setup.py (path:/tmp/pip-SWCQtZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 11:22:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:32 INFO - Running setup.py (path:/tmp/pip-RTBQJa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 11:22:32 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)) 11:22:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:33 INFO - Running setup.py (path:/tmp/pip-gldshP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 11:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 11:22:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:33 INFO - Running setup.py (path:/tmp/pip-981Ms9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 11:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 11:22:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:33 INFO - Running setup.py (path:/tmp/pip-eBkvc2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 11:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 11:22:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:33 INFO - Running setup.py (path:/tmp/pip-Tlnbtf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 11:22:33 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)) 11:22:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:33 INFO - Running setup.py (path:/tmp/pip-TUINC0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 11:22:33 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)) 11:22:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:33 INFO - Running setup.py (path:/tmp/pip-dHtYMJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 11:22:33 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)) 11:22:33 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)) 11:22:33 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)) 11:22:33 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)) 11:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 11:22:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 11:22:33 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 11:22:33 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 11:22:33 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 11:22:33 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 11:22:33 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 11:22:33 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 11:22:35 INFO - Downloading blessings-1.6.tar.gz 11:22:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 11:22:35 INFO - Installing collected packages: blessings 11:22:35 INFO - Running setup.py install for blessings 11:22:35 INFO - Successfully installed blessings 11:22:35 INFO - Cleaning up... 11:22:35 INFO - Return code: 0 11:22:35 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 11:22:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:22:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:22:35 INFO - Reading from file tmpfile_stdout 11:22:35 INFO - Current package versions: 11:22:35 INFO - argparse == 1.2.1 11:22:35 INFO - blessings == 1.6 11:22:35 INFO - blobuploader == 1.2.4 11:22:35 INFO - docopt == 0.6.1 11:22:35 INFO - manifestparser == 1.1 11:22:35 INFO - mozInstall == 1.12 11:22:35 INFO - mozcrash == 0.16 11:22:35 INFO - mozdebug == 0.1 11:22:35 INFO - mozdevice == 0.47 11:22:35 INFO - mozfile == 1.2 11:22:35 INFO - mozhttpd == 0.7 11:22:35 INFO - mozinfo == 0.9 11:22:35 INFO - mozleak == 0.1 11:22:35 INFO - mozlog == 3.1 11:22:35 INFO - moznetwork == 0.27 11:22:35 INFO - mozprocess == 0.22 11:22:35 INFO - mozprofile == 0.27 11:22:35 INFO - mozrunner == 6.11 11:22:35 INFO - mozscreenshot == 0.1 11:22:35 INFO - mozsystemmonitor == 0.0 11:22:35 INFO - moztest == 0.7 11:22:35 INFO - mozversion == 1.4 11:22:35 INFO - psutil == 3.1.1 11:22:35 INFO - requests == 1.2.3 11:22:35 INFO - wsgiref == 0.1.2 11:22:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 11:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb018dedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257da50>, '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 0x24e9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e99e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', '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 11:22:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:22:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:22:35 INFO - Using env: {'DISPLAY': ':0', 11:22:35 INFO - 'HOME': '/home/cltbld', 11:22:35 INFO - 'LANG': 'en_US.UTF-8', 11:22:35 INFO - 'LANGUAGE': 'en_US:en', 11:22:35 INFO - 'LOGNAME': 'cltbld', 11:22:35 INFO - 'MAIL': '/var/mail/cltbld', 11:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:35 INFO - 'MOZ_NO_REMOTE': '1', 11:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:35 INFO - 'NO_EM_RESTART': '1', 11:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:35 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:35 INFO - 'SHELL': '/bin/bash', 11:22:35 INFO - 'SHLVL': '1', 11:22:35 INFO - 'TERM': 'linux', 11:22:35 INFO - 'TMOUT': '86400', 11:22:35 INFO - 'USER': 'cltbld', 11:22:35 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', 11:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:35 INFO - '_': '/tools/buildbot/bin/python'} 11:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:35 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)) 11:22:35 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)) 11:22:35 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)) 11:22:35 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)) 11:22:35 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)) 11:22:35 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)) 11:22:35 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)) 11:22:35 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)) 11:22:35 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)) 11:22:35 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)) 11:22:35 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)) 11:22:35 INFO - Cleaning up... 11:22:35 INFO - Return code: 0 11:22:35 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 11:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:35 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb018dedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257da50>, '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 0x24e9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e99e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', '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 11:22:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:22:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:22:35 INFO - Using env: {'DISPLAY': ':0', 11:22:35 INFO - 'HOME': '/home/cltbld', 11:22:35 INFO - 'LANG': 'en_US.UTF-8', 11:22:35 INFO - 'LANGUAGE': 'en_US:en', 11:22:35 INFO - 'LOGNAME': 'cltbld', 11:22:35 INFO - 'MAIL': '/var/mail/cltbld', 11:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:35 INFO - 'MOZ_NO_REMOTE': '1', 11:22:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:35 INFO - 'NO_EM_RESTART': '1', 11:22:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:35 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:35 INFO - 'SHELL': '/bin/bash', 11:22:35 INFO - 'SHLVL': '1', 11:22:35 INFO - 'TERM': 'linux', 11:22:35 INFO - 'TMOUT': '86400', 11:22:35 INFO - 'USER': 'cltbld', 11:22:35 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', 11:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:35 INFO - '_': '/tools/buildbot/bin/python'} 11:22:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:36 INFO - Downloading/unpacking jsonschema 11:22:36 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 11:22:36 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 11:22:36 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 11:22:36 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 11:22:36 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 11:22:36 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 11:22:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:22:37 INFO - Downloading/unpacking functools32 (from jsonschema) 11:22:37 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 11:22:37 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 11:22:37 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 11:22:37 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 11:22:37 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 11:22:37 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 11:22:38 INFO - Downloading functools32-3.2.3-2.tar.gz 11:22:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 11:22:38 INFO - warning: no files found matching '*.txt' 11:22:38 INFO - no previously-included directories found matching 'build' 11:22:38 INFO - no previously-included directories found matching 'dist' 11:22:38 INFO - no previously-included directories found matching '.git*' 11:22:38 INFO - Installing collected packages: jsonschema, functools32 11:22:38 INFO - Running setup.py install for functools32 11:22:38 INFO - warning: no files found matching '*.txt' 11:22:38 INFO - no previously-included directories found matching 'build' 11:22:38 INFO - no previously-included directories found matching 'dist' 11:22:38 INFO - no previously-included directories found matching '.git*' 11:22:38 INFO - Successfully installed jsonschema functools32 11:22:38 INFO - Cleaning up... 11:22:38 INFO - Return code: 0 11:22:38 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 11:22:38 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')]} 11:22:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:38 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')]} 11:22:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:38 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fb018dedf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x241d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24eb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x257da50>, '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 0x24e9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e99e0>, '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': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', '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 11:22:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 11:22:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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 11:22:38 INFO - Using env: {'DISPLAY': ':0', 11:22:38 INFO - 'HOME': '/home/cltbld', 11:22:38 INFO - 'LANG': 'en_US.UTF-8', 11:22:38 INFO - 'LANGUAGE': 'en_US:en', 11:22:38 INFO - 'LOGNAME': 'cltbld', 11:22:38 INFO - 'MAIL': '/var/mail/cltbld', 11:22:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:38 INFO - 'MOZ_NO_REMOTE': '1', 11:22:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:38 INFO - 'NO_EM_RESTART': '1', 11:22:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:38 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:38 INFO - 'SHELL': '/bin/bash', 11:22:38 INFO - 'SHLVL': '1', 11:22:38 INFO - 'TERM': 'linux', 11:22:38 INFO - 'TMOUT': '86400', 11:22:38 INFO - 'USER': 'cltbld', 11:22:38 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', 11:22:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:38 INFO - '_': '/tools/buildbot/bin/python'} 11:22:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:38 INFO - Downloading/unpacking flake8 11:22:38 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 11:22:38 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 11:22:38 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 11:22:38 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 11:22:38 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 11:22:38 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 11:22:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:22:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:22:40 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 11:22:40 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 11:22:40 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 11:22:40 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 11:22:40 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 11:22:40 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 11:22:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:22:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:22:40 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 11:22:40 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 11:22:40 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 11:22:40 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 11:22:40 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 11:22:40 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 11:22:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:22:40 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 11:22:40 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 11:22:40 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 11:22:40 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 11:22:40 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 11:22:40 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 11:22:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 11:22:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:22:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:22:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:22:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:22:40 INFO - no previously-included directories found matching 'docs/_build' 11:22:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:22:41 INFO - Running setup.py install for pep8 11:22:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:22:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:22:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:22:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:22:41 INFO - no previously-included directories found matching 'docs/_build' 11:22:41 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 11:22:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:22:41 INFO - Cleaning up... 11:22:41 INFO - Return code: 0 11:22:41 INFO - Running post-action listener: _resource_record_post_action 11:22:41 INFO - Running post-action listener: _start_resource_monitoring 11:22:41 INFO - Starting resource monitoring. 11:22:41 INFO - ##### 11:22:41 INFO - ##### Running install step. 11:22:41 INFO - ##### 11:22:41 INFO - Running pre-action listener: _resource_record_pre_action 11:22:41 INFO - Running main action method: install 11:22:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 11:22:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 11:22:41 INFO - Reading from file tmpfile_stdout 11:22:41 INFO - Detecting whether we're running mozinstall >=1.0... 11:22:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 11:22:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 11:22:41 INFO - Reading from file tmpfile_stdout 11:22:41 INFO - Output received: 11:22:41 INFO - Usage: mozinstall [options] installer 11:22:41 INFO - Options: 11:22:41 INFO - -h, --help show this help message and exit 11:22:41 INFO - -d DEST, --destination=DEST 11:22:41 INFO - Directory to install application into. [default: 11:22:41 INFO - "/builds/slave/test-pgo"] 11:22:41 INFO - --app=APP Application being installed. [default: firefox] 11:22:41 INFO - mkdir: /builds/slave/test-pgo/build/application 11:22:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 11:22:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 11:22:56 INFO - Reading from file tmpfile_stdout 11:22:56 INFO - Output received: 11:22:56 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 11:22:56 INFO - Running post-action listener: _resource_record_post_action 11:22:56 INFO - ##### 11:22:56 INFO - ##### Running run-tests step. 11:22:56 INFO - ##### 11:22:56 INFO - Running pre-action listener: _resource_record_pre_action 11:22:56 INFO - Running main action method: run_tests 11:22:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 11:22:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 11:22:56 INFO - Python 2.7.3 11:22:56 INFO - Return code: 0 11:22:56 INFO - grabbing minidump binary from tooltool 11:22:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:22:56 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 0x257da50>, '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 0x24e9550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e99e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 11:22:56 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 11:22:56 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 11:22:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:22:56 INFO - Return code: 0 11:22:56 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 11:22:56 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 11:22:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 11:22:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 11:22:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 11:22:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 11:22:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 11:22:57 INFO - Return code: 0 11:22:57 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/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 11:22:57 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/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost 11:22:57 INFO - Using env: {'DISPLAY': ':0', 11:22:57 INFO - 'HOME': '/home/cltbld', 11:22:57 INFO - 'LANG': 'en_US.UTF-8', 11:22:57 INFO - 'LANGUAGE': 'en_US:en', 11:22:57 INFO - 'LOGNAME': 'cltbld', 11:22:57 INFO - 'MAIL': '/var/mail/cltbld', 11:22:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:22:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 11:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:57 INFO - 'MOZ_NO_REMOTE': '1', 11:22:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 11:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:57 INFO - 'NO_EM_RESTART': '1', 11:22:57 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 11:22:57 INFO - 'PWD': '/builds/slave/test-pgo', 11:22:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 11:22:57 INFO - 'SHELL': '/bin/bash', 11:22:57 INFO - 'SHLVL': '1', 11:22:57 INFO - 'TERM': 'linux', 11:22:57 INFO - 'TMOUT': '86400', 11:22:57 INFO - 'USER': 'cltbld', 11:22:57 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594', 11:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:57 INFO - '_': '/tools/buildbot/bin/python'} 11:22:57 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/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] with output_timeout 3600 11:22:57 INFO - mozversion INFO | application_buildid: 20160125032407 11:22:57 INFO - mozversion INFO | application_changeset: 3bfa5bc61b626761d487b45c170b115259f69d6b 11:22:57 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 11:22:57 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:22:57 INFO - mozversion INFO | application_name: Firefox 11:22:57 INFO - mozversion INFO | application_remotingname: firefox-dev 11:22:57 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:22:57 INFO - mozversion INFO | application_vendor: Mozilla 11:22:57 INFO - mozversion INFO | application_version: 45.0a2 11:22:57 INFO - mozversion INFO | platform_buildid: 20160125032407 11:22:57 INFO - mozversion INFO | platform_changeset: 3bfa5bc61b626761d487b45c170b115259f69d6b 11:22:57 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:22:57 INFO - mozversion INFO | platform_version: 45.0a2 11:22:57 INFO - 2016-01-25 11:22:57,465 DEBUG : using testdate: 1453749777 11:22:57 INFO - 2016-01-25 11:22:57,465 DEBUG : actual date: 1453749777 11:22:57 INFO - 2016-01-25 11:22:57,514 INFO : starting webserver on 'localhost:34091' 11:22:57 INFO - 2016-01-25 11:22:57,515 INFO : Starting test suite talos-linux64-ix-055.e 11:22:57 INFO - 2016-01-25 11:22:57,515 INFO : Starting test dromaeo_css 11:22:57 INFO - 2016-01-25 11:22:57,515 DEBUG : operating with platform_type : linux_ 11:22:57 INFO - 2016-01-25 11:22:57,516 INFO : Initialising browser for dromaeo_css test... 11:22:57 INFO - 2016-01-25 11:22:57,530 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmtipA0/profile http://localhost:34091/getInfo.html 11:23:00 INFO - 2016-01-25 11:23:00,884 DEBUG : BROWSER_OUTPUT: 11:23:00 INFO - 2016-01-25 11:23:00,884 DEBUG : BROWSER_OUTPUT: (process:32434): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:23:01 INFO - 2016-01-25 11:23:01,752 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:23:01 INFO - 2016-01-25 11:23:01,752 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:23:01 INFO - 2016-01-25 11:23:01,752 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:23:01 INFO - 2016-01-25 11:23:01,752 DEBUG : BROWSER_OUTPUT: __metrics 11:23:02 INFO - 2016-01-25 11:23:02,721 INFO : Browser initialized. 11:23:02 INFO - 2016-01-25 11:23:02,721 INFO : Running cycle 1/1 for dromaeo_css test... 11:23:02 INFO - 2016-01-25 11:23:02,722 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpmtipA0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:23:04 INFO - 2016-01-25 11:23:04,044 DEBUG : BROWSER_OUTPUT: 11:23:04 INFO - 2016-01-25 11:23:04,045 DEBUG : BROWSER_OUTPUT: (process:32547): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:23:14 INFO - 2016-01-25 11:23:14,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 136261632 11:23:14 INFO - 2016-01-25 11:23:14,549 DEBUG : BROWSER_OUTPUT: 11:24:04 INFO - 2016-01-25 11:24:04,177 DEBUG : BROWSER_OUTPUT: 1453749844176 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] 11:26:11 INFO - 2016-01-25 11:26:11,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34091/tests/dromaeo/cssquery-ext.html) 11:26:12 INFO - 2016-01-25 11:26:12,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 141647872 11:26:12 INFO - 2016-01-25 11:26:12,950 DEBUG : BROWSER_OUTPUT: 11:29:14 INFO - 2016-01-25 11:29:14,769 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/dromaeo/cssquery-ext.html (next: http://localhost:34091/tests/dromaeo/cssquery-jquery.html) 11:29:15 INFO - 2016-01-25 11:29:15,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 139952128 11:29:15 INFO - 2016-01-25 11:29:15,371 DEBUG : BROWSER_OUTPUT: 11:32:17 INFO - 2016-01-25 11:32:17,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34091/tests/dromaeo/cssquery-mootools.html) 11:32:17 INFO - 2016-01-25 11:32:17,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 138784768 11:32:17 INFO - 2016-01-25 11:32:17,584 DEBUG : BROWSER_OUTPUT: 11:35:19 INFO - 2016-01-25 11:35:19,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34091/tests/dromaeo/cssquery-prototype.html) 11:35:19 INFO - 2016-01-25 11:35:19,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 139735040 11:35:19 INFO - 2016-01-25 11:35:19,740 DEBUG : BROWSER_OUTPUT: 11:38:21 INFO - 2016-01-25 11:38:21,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34091/tests/dromaeo/cssquery-yui.html) 11:38:22 INFO - 2016-01-25 11:38:22,571 DEBUG : BROWSER_OUTPUT: RSS: Main: 140681216 11:38:22 INFO - 2016-01-25 11:38:22,571 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/dromaeo/cssquery-yui.html (next: http://localhost:34091/tests/dromaeo/cssquery-dojo.html) 11:41:24 INFO - 2016-01-25 11:41:24,842 DEBUG : BROWSER_OUTPUT: RSS: Main: 142389248 11:41:24 INFO - 2016-01-25 11:41:24,842 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,842 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:41:24 INFO - 2016-01-25 11:41:24,843 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:41:24 INFO - 2016-01-25 11:41:24,843 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:41:24 INFO - 2016-01-25 11:41:24,843 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:41:24 INFO - 2016-01-25 11:41:24,843 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3225.3710526447344;3283.080737393531;3291.9835400822994;3310.222097807016;3321.070100371895;5493.285872836531;5530.723463826803;5533.418991005947;5549.223108764776;5551.056320425528;5500.559955203584;5504.256925315081;5516.834494965157;5557.694326812024;5579.995600791855;5032.220005899091;5062.645614806965;5138.820141295056;5139.12634852076;5172.043172013189;4903.215485522317;5007.924881126786;5077.035363280965;5079.085764562377;5117.795288188468;5009.524095210949;5086.542211200991;5092.821751238707;5098.821541246057;5196.740162991835;5059.16523773577;5068.949310506885;5072.315237442954;5081.491850814908;5108.565771909392;4859;4906.950930490685;4954.7274899880495;5031.295618613397;5063.164577844651;5313.9734301328635;5340.118880384732;5356.464353564651;5422.593305502063;5424.05079111154;5961.403859614047;5984.581079324449;6003.009503431972;6041.335453100155;6049.274087109531;5755.884882302373;5848.385919478436;5921.644701317935;6033.577649564532;6073.848153796146;5566.471185237396;5566.721663916828;5577;5595.104783234704;5595.692236926968;6025.487833534199;6031.788887388921;6033.3966603340195;6035.909461358083;6036.0644100164545;5676.205331253628;5736.971315143398;5781.5952883298605;5806.187133801187;5833.504152147115;5865.94134058654;5895.41045895407;5914.231149950565;5933.881322373529;5983.192269043623;5680.403557626472;5872.823815285548;5901.940980590139;5910.290765108214;5935.169076329317;5829.5044921181325;5882.23530940975;5965.194698715618;5977.133315669291;6003.189569408161;4619.0530941156985;4623.53764623535;4624.5375462453485;4630.83792067276;4650.697704649187;4005.439238506611;4091.7135800494275;4106.815193316308;4111.362738775495;4124.8556300529335;5667.376588575254;5698.031334673115;5723.227364305765;5768.826935191951;5794.88410231793;5940.732667029994;5948.67282299469;5950.761969521171;5951.940480595225;5975.43233392827;5445;5543.501084902378;5548.4174161713245;5674.801381951695;5687.630304030225;5092.185250359925;5139.897202056013;5142.871428214325;5145.434002259748;5245.213218017251;6166.845828854314;6196.907046394308;6197.5351848611535;6200.751969921243;6203.410675985774;5992.43071908168;6025.969870150621;6026.728797204224;6038.728257228523;6063.818085457443;5905.793297234748;6026.668533230539;6047.879042419215;6124.448799608057;6140.263168419819;5859.648421094577;5861.35525092231;5878.617889837147;5879.323877753942;5903.940960590339;5753.8561535961935;6023.066424704178;6026.15633811258;6026.638401695912;6027.397260274113;5706.343770466449;5815.709214539341;5881.088431293157;5891.263592050994;5918.496927761188;5840.883182336414;5900.90833195843;5902.498287645427;5904.645721256738;5905.763769449174;5508.366537848199;5615;5764.884702305846;5813.883722325445;5824.825255242349;5815.447532484407;5841.4450627190345;5888.764449422147;5908.940910590839;5913.113033045078;5760.164776107525;5813.651180929158;5830.154627579062;5830.9416905832095;5831.854203644943 11:41:24 INFO - 2016-01-25 11:41:24,844 DEBUG : BROWSER_OUTPUT: |1;ext.html;635.2123367024889;642.7525402719955;645.5674697952371;651.2998526583923;658.5818005566464;41156.588434115685;41859;41915.99999999996;42094.789526052366;42124.578754212445;43835;44138.55861441392;44162.337564936555;44289.7785511072;44333.11333773322;8737.082606326323;8850.955745221265;8896.288296936262;8898.955505222464;8933.28533717301;8772.868406973901;8779.912200878005;8795.296376289882;8870.822583548324;8881.200691937724;8772.254358379514;8805.295576353908;8873.822523549525;8880.866786998167;8885.155910188521;8791.824163516758;8822.558872056403;8833.293336533063;8851.159139881702;8866.069062748447;8622.568871556397;8804.515751633657;8809.38334316598;8824.382293239476;8838.381313308071;39370.40944385836;39846.402303965464;39871.40192897109;39900.60099399027;39952.400713989315;3781.9054523636855;3885.7668539887695;4188.036751547131;4213.157368526307;4333.393324934512;32148.19629509281;32448.188795280308;32510.349793004007;32544.6745532544;32554.511682324784;3600;3652.689521390685;3808.5810560838286;3853.094522787143;3865.4974853269177;281023;281251;282497;282934.99999999796;283634;45395;46121;46291.07417851624;46498.07003859904;64629;43947.34078988818;44024;44086.55913440824;44105.77947110308;44137;15906.12516311614;15918.204089795463;16037.67924641524;16043.278052487665;16062.678746425006;12774.361281935866;12819.230846149261;12922.483100675867;12980.610581682564;12983.805242921364;15406.614834629225;15444.768328475082;15523;15594.220288985505;15675.294611742498;6220;6253.906191407133;6265.749370025239;6395.936040639534;6396.968015159894;1016.7051555048953;1023.8515415264894;1049.9107575856137;1088.1403691083956;1163.30201878872;30040;30137;30498.542521861746;30504.54243186354;30711;1133.886611338876;1167.1870791392873;1167.795635763738;1223.2966044524435;1291.3285091752236;15864.841351586567;15896.364145434285;16012.919935400249;16135.435259765853;16253.431129910396;349371;561562;574438;577633;942409;58350;59184.70407647934;59298.40701592929;59419.108713369336;59521.40478595245;1490.5751860719643;1512.447956495871;1518.3850540531103;1531.3568301313253;1533.9693206135814;31836.52245216277;32229.194270143435;32381.90153478193;32652.673473264964;33177.33645327032;50669;51148.488515114375;51157.7442112787;51161.23258151205;51349.22976155435;322411;323772;324278;324676;324733;35282.647173527934;35426.64573354233;35620.109497262776;35760.46359304665;35916.82041589775;47433.762831185624;47859.04281914412;48290.51709483001;48465.27302090542;48655;40383.79808100941;40486.392704110054;40940.36238550544;40949;41779.58220417757;40004.79997599994;41099.58900410958;43378.78310608553;46887.765561171975;47478.76260618675;39306.41040384454;39787.80106099451;39805.203895922496;39904.40143397793;39952.800235998635;39082.72103571496;40979.59020409877;41150.7979804988;41951.37072943847;42112.57887421086;26689.599656005565;27568.44863102767;27618.723812761615;27842.721572784012;28043.158705238875 11:41:24 INFO - 2016-01-25 11:41:24,844 DEBUG : BROWSER_OUTPUT: |2;jquery.html;383.3349139243412;383.75439718580094;384.04373110953725;387.6762902976015;395.2293028594242;16266.593335166626;16836.41072562459;18166;18432.539186520327;18481;11629.883701162986;11832.822507662371;11902;17478.912605436955;17822.19800108995;5026.62300327476;5047.167217409123;5166.870828229286;5167.7932882684645;5168.379794424655;5095.0574143783515;5393.865153371177;5531;5546.417626149257;5555.2778138841895;5435.728213589325;5480.534154596864;5499.50504454599;5513.58648101392;5527.474889885454;4740;5718.6568805871575;5751.424857514257;5752.28096487939;5758.856028599276;5429.429909859447;5522.6134170608075;5533.446655334475;5537.916931246034;5551.528120109796;13924.58226253214;14199.935004874573;14222.431102755878;15046.699066018728;22100;2152.2467136502255;2152.630160773632;2160.79472450117;2214.136486770161;2357.198552492144;10292.588296468133;10506.737331566696;10716.892831071667;12093.911547960726;14043.929780351134;1933.5359513716608;1935.6612592796205;1940.3111895277113;2040.6938959156098;2055.629986602411;65621;67253;68031;68663.65668171678;69255;10816.78366432667;11013.449327533592;11085.279456835442;11129.833052504218;11150.721231969103;14554.636134096732;14584.854151458561;14614.707705846036;14655.413783448756;14661.413543458355;8045.5574943377505;8081.919180808117;8118.660421030582;8173.959130204311;8236.052853921756;7997.680092796223;8014.278714915686;8020;8035.477693949874;8067.273945344829;4662.32396302541;4740.051989602093;4741.881452963704;4772.284157376352;4783.019481006385;1735.947921562355;1806.8102849200907;1817.3275887921554;1973.8618296719092;1983.5239542509983;463.4461818127306;480.1741005470585;927.5825878354767;1024.8580466824374;1119.7200699825044;10806.675799726021;11565.884341156481;11656.650300491;11682.182247242612;11819.172657914036;492.1608657239398;515.6725479320659;1010.7422607235108;1029.7785976015193;1072.8658917635296;9417.340786145041;9534.141927226445;9574.377665451724;9618.567164477616;9803.313768036169;659580;664860;681292;687135;700725;88236;89120.55439722759;90196;90497.09502905018;92872.53563732139;1147.05941128274;1149.1668540308376;1189.191349882071;1200.291827821572;1203.199872085071;15574.766378504104;15672.764908526153;15730.528084157493;15732.60668483297;15759.290831912362;35130.297394051464;35499.467507987916;35866.64133358633;36038.45942310815;36899.63100368962;42000.57999419967;42764.572354277305;42940.141197176505;45236;45681.54318456773;10281.588736450758;10367.170626350025;10424.374537527772;10468;10510.211734120125;13491.392887320291;17724.113794309975;18052.458426247234;18190;18404.723929141343;10394.844077338696;14729.92635036818;14913;15156.545303640467;15200.771988419961;15187;15685.843141568439;16083.919580402024;16214.10822404779;16393.18034098314;14921.776173357192;15645.530634080997;15741.370345186064;15949.760753588938;16176.110313932846;10028.548715307974;10066.748331291776;10113.64602238918;10227.94886025565;10299.588016479256;11255.549778008788;11711.765764684487;15569.68860622804;15726.606834829221;15975.440859569859 11:41:24 INFO - 2016-01-25 11:41:24,845 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1479.9408023679052;1725.2064050536753;1798.1908141336403;1858.0616788521795;1859.460756380649;6976.616286104262;7152.213256541776;7440.5535667859895;7917.3270272026875;7919.841603167941;7282.56304621723;7495.812604684886;7550.773476795691;7560.848783024337;7574.962125189366;2225.9777402225973;2258.7176602924633;2270.0919632147193;2278.2254033628565;2281.7147856517936;2305.250793492113;2326.906923723049;2352.529494101178;2354.211339201361;2359.9882000589973;2163.642998905179;2167.8265738740943;2175.662772270293;2269.965950510744;2283.8515496492673;2190.8575942563684;2222.022310183522;2223.9110435582556;2239.73123225214;2247.932232189705;2301.2290882554366;2315.6758053872472;2326.7789559991775;2328.0455013444575;2330.953380932389;7834.804129896741;7872.724454644117;7877.330426913719;7893.447458677895;7909.644066017043;4624.3757092792375;4672.275797251432;4720.480747117815;4724.692894961817;4728.716277023355;2876.6548014238424;2971.242333205019;3016.5324374721954;3038.893638722634;3049.8780048798244;900.1313732248411;913.0413066280379;913.7258822353334;996.9551370188359;1000.8798944126679;10780.353178809297;10865.67402977904;10896.455177241107;10911.727206819814;10915.399653019082;4219.894502637459;4261.105167914772;4262.531121576624;4297.914041719148;4313.654907607384;9296.116868897443;9378.109079637423;9385.718428447157;9387.765305867408;9405.247580193569;4755.239161734106;4762.499937506581;4766.356541866873;4770.976145119253;4795.112904112751;4233.767142807175;4336.089421221515;4355.128974205171;4368.5194628590825;4416.381706561084;3569.982150089233;3589.748717589796;3609.3864043112208;3612.2233719749856;3616;1071.892810718922;1077.4020418667715;1085.6200329884477;1090.1932569898217;1093.4532733633184;1187.6437068879302;1192.1059205595802;1200.0759415250209;1447.7828325751223;1477.106350657858;7606.3914886808925;7656.655450504741;7665.961670191613;7667.156612772591;7668.348190403766;507.5229284472584;510.7752588860889;512.8794733237686;514.3133916221885;514.6757542748045;5855.560832937462;5855.648661080349;5873.295204575393;5894.498967587803;5907.054871220584;9030.729078127666;9353.532323383804;9373.531323433801;9391.389559678599;9503.239740820718;9290.907090929139;9335.533223338805;9343.71968840936;9373.859392109123;9408.858867116998;7180.640967951582;7309.159446663702;7383.2985866342615;7435.739749108755;7444.59054751983;7080.858382832417;7090.645467726697;7091.11361079865;7162.104736907887;7186.892196617159;8183.386246031452;8218.958905205436;8380.20388063133;8387.496750195009;8572.52851093196;8220.917790822015;8431.915680843113;8456.577171141542;8499.065102838558;8579.65681372763;5947.3457919627945;6393.232812062396;6933.375996160168;6993.055937448583;6994.790156295319;7521.586312752851;7524.736634217776;7591.316781489692;7624.313811756969;7647.617619119133;7083.114610673666;7198.064251647253;7233.819154520968;7334.266573342623;7347.5224110432655;6973.546719463218;7016.298370162943;7067;7148.64256787169;7155.141383034069;7126.011537636771;7253.274672532704;7305.196428392979;7311.744088956861;7311.744088956861;6738.09035780183;6754.0881980931945;6760.560563563353;6788.049673045876;6794.93205067943;6433.646149461824;6621.834454138492;6637.800865974028;6703.497237707289;6828.419584335387 11:41:24 INFO - 2016-01-25 11:41:24,847 DEBUG : BROWSER_OUTPUT: |4;prototype.html;350.56004714083826;355.2646022732944;361.1909323116219;361.6112678870214;363.7890023786204;6364.618122912629;6390.52071094668;6455.677216139186;6479.838004049901;6494.123293355401;6180.938190618092;6330.177076979986;6352.936470635293;6357.586756860801;6372.107904893307;4842.394700662418;4845.200541910589;4845.909670324167;4849.369581954341;4849.733264670442;4885.8778530536665;4900.215965445529;4900.558949694527;4908.8281910133155;4911.140550403683;4815.518448155191;4873.1715608346485;4881.145799485093;4891.461939186686;4906.1168989581865;4913;4939.580135688453;4940.036692844897;4943.307936888838;4945.653804233705;4346.587074227943;4351.630111440531;4355.825766969318;4358.847440339605;4362;5932.673702946337;6044.697765111727;6062.151298818169;6064.696765161769;6066.63600183986;5734.4265573442735;5747.568932330092;5750.338711048241;5756.079027355603;5764.798232061899;6734.8989765153565;6770.289119642465;6770.69531871067;6773.3903948644365;6793.422559082434;4782.760861956888;4816.301636262722;4819.397575303087;4824;4836.41962964443;6889.689963951634;6908.861822763567;7070.328318809705;7073.964630176868;7084.964575177142;4771.4512831024185;4810.158222311082;4813.181759100961;4813.350197723333;4816;4865.781039853215;4865.8053677853195;4866.391701037371;4866.9269960949905;4888.975555122272;5536;5602.411746766612;5620.241267428844;5635.549156067586;5636.18275350072;6702.899456508157;6762.492813039042;6771.085903403076;6773.45812335012;6776.2546119926765;1739.956501087483;1773.873590270162;1779.2616064333156;1782.1980108951025;1782.7860656721018;1197.7724232395817;1198.2870192235605;1203.3562044306254;1211.7818792617238;1221.0902877356248;6341;6513.674316284167;6549.901751473732;6560.6063636181025;6584.86830263392;6962.268961759044;6969.2682268361095;6995.720171193197;7006.824829379307;7013.26360732126;6428.742850286029;6491.837704057436;6503.902441463382;6518.641474718936;6554.7378104876225;3784.4323351496946;3794.1083845296334;3823.1780167264174;3828.8277027533827;3834.6932245420858;7203.819904502429;7249.98500209971;7256.4557658175845;7257.709691612382;7268.96365518169;6991.161060672752;7113.502054856111;7141.285871412817;7149.285071492809;7180.138383394026;7237.963810181021;7252.274772522811;7253.5647861127445;7255.854882902312;7256.6734496947765;7009.684564194726;7013.754518591825;7021.613811240431;7027.9297207027275;7029.226785053538;6760.391564759196;6837.58974461514;6852.45180385558;6883.931160688529;6886.896696549656;7177.4616903731385;7213.495055346076;7230.602316872622;7235;7246.6376681164675;4944.554990050912;4976.328195693535;4984.651074424755;4986.7257300848805;5009.77456014473;6906.37842594169;6938.583684978716;6988.021676965331;6997.755078572225;7021.5787052777;6830;6893.931060689329;6914.585124892523;6937.340952609494;6938.895916561357;6857.525631989146;6882.242953275236;6895.069165662571;6898.620575868375;6915.965420172867;6641.402273795188;6759.662016899234;6762.425193858577;6766.424853887278;6768.763093291711;6896.862062758817;6932.480063995321;6939.687714052779;6945.583265004116;6949.061876646791;6579.243387010555;6655.068290439439;6684.0642310075655;6689.832754181184;6710.496712746466 11:41:24 INFO - 2016-01-25 11:41:24,850 DEBUG : BROWSER_OUTPUT: |5;yui.html;815.4332738746574;930.1024511346545;950.6767698982345;960.9951950240247;962.817064757696;13630.659233519167;13761.380737866795;13764.242966636832;13813.930930345334;13919.164850109;14388.856111438883;14389.712205755879;14433.422663093465;14464.710705785878;14485.493007744732;886.9911300886989;897.1701176411825;916.9816603667923;918.334207699416;923.376720713519;901.8557030875062;901.9052999435063;902.5803001604253;903.8237543678986;908.9454632722025;965.9613615455409;967.5984466446452;967.9419234845897;970.2141265574871;971.8542218667186;949.5679465843094;957.0572985609169;959.122403001253;959.7504648791295;961.8461046232604;696.8745625787357;704.9295070492961;706.3184027413571;711.1111111111111;712.2699233285872;14948.62628434287;15115.848841511553;15123.697526049527;15125.697486050218;15126.394944202219;12158.696032599168;12218.26690398579;13015.958723302114;13362.465501379933;13740.450381984709;10689.83965240522;10731.141508679366;10871.728206794814;11357.945714157204;11841.763164736743;3861.903452413684;3875.7286989910717;3909.4722212501233;3936.7834769087976;3947.980260098681;49750.253746193834;49867;50042.49957500415;50262.49737502615;50548.24177637338;9434.150926416656;9459.479728614855;9463.810723785486;9879.950600247097;10530.104941080093;18969.81030189708;19068.427947161606;19099.90450047741;19117.522061948286;19129.13918873654;8351;8366.163383661586;8390.916090839135;8441.155884411632;8619.482831030033;4402.075564131568;4549.7042692224895;4566.908661826745;4575.931361029588;4845.297431872359;3270.689284517967;3293.094399040283;3295.340931813599;3301.059198128522;3304.6530114337647;544.1538407775946;549.5768258440978;553.6290685240898;563.2171281918137;563.6843367714093;695.3776370148789;706.4030893894651;714.3035540348222;738.7082102569562;741.4846681556375;9077.863832042525;9675.127559258503;9729.805403891882;9830.901690983143;9860.506974651382;686.7321744519642;711.164381851333;746.8170298276957;775.2324699684727;782.62042909189;4446.822127114944;4498.887527811831;4608.28571571407;4632.2125238709505;4672.696274742131;64337;66245.33754662488;66441;66732;67119;57331.2734672245;58058.7097064512;58364.708176458844;58710;58740.412595874346;52260.47739522632;52561.7371913138;52799;53303.73348133157;53506;8762.211400973943;8781.429207101519;9053.773655658399;9382.859257111013;9435.716928492157;40236;40517.59482405256;40562.18875622412;40569.59430405776;43036.569634303254;50532;50601.49398505968;50926.490735093656;51047;51142.23286650777;10223.386596804216;11524.078073754246;12055;12104;12353.197042192229;13116.409761560562;13167;13612.930540681735;13711.657208569466;14116.50592229267;10602.151827853908;10876.782464350827;10917.508712107816;10954;10958.39728814891;10836.133109351076;11050.557977680803;11723.824142637697;12061.698457538281;12220.205686630341;9977.900220997697;11968.013685686805;12108.75782484363;12382.81425778632;12642.55751048709;9256.213221876216;9312.301577381588;9521.2859035574;9570.95214523923;10218.948905255425;10360.792784144123;10455.738606534898;10474.266801323834;10599.947000264949;11058.778824423305 11:41:24 INFO - 2016-01-25 11:41:24,850 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:41:24 INFO - 2016-01-25 11:41:24,850 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:41:24 INFO - 2016-01-25 11:41:24,851 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,308 11:41:24 INFO - 2016-01-25 11:41:24,851 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:41:24 INFO - 2016-01-25 11:41:24,851 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750884835__endTimestamp 11:41:24 INFO - 2016-01-25 11:41:24,851 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,851 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:41:24 INFO - 2016-01-25 11:41:24,851 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:41:24 INFO - 2016-01-25 11:41:24,851 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,852 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5527.57 Median:5764.88 stddev:615.07 (10.7%) stddev-sans-first:589.84 11:41:24 INFO - 2016-01-25 11:41:24,852 DEBUG : BROWSER_OUTPUT: Values: 3225.4 3283.1 3292.0 3310.2 3321.1 5493.3 5530.7 5533.4 5549.2 5551.1 5500.6 5504.3 5516.8 5557.7 5580.0 5032.2 5062.6 5138.8 5139.1 5172.0 4903.2 5007.9 5077.0 5079.1 5117.8 5009.5 5086.5 5092.8 5098.8 5196.7 5059.2 5068.9 5072.3 5081.5 5108.6 4859.0 4907.0 4954.7 5031.3 5063.2 5314.0 5340.1 5356.5 5422.6 5424.1 5961.4 5984.6 6003.0 6041.3 6049.3 5755.9 5848.4 5921.6 6033.6 6073.8 5566.5 5566.7 5577.0 5595.1 5595.7 6025.5 6031.8 6033.4 6035.9 6036.1 5676.2 5737.0 5781.6 5806.2 5833.5 5865.9 5895.4 5914.2 5933.9 5983.2 5680.4 5872.8 5901.9 5910.3 5935.2 5829.5 5882.2 5965.2 5977.1 6003.2 4619.1 4623.5 4624.5 4630.8 4650.7 4005.4 4091.7 4106.8 4111.4 4124.9 5667.4 5698.0 5723.2 5768.8 5794.9 5940.7 5948.7 5950.8 5951.9 5975.4 5445.0 5543.5 5548.4 5674.8 5687.6 5092.2 5139.9 5142.9 5145.4 5245.2 6166.8 6196.9 6197.5 6200.8 6203.4 5992.4 6026.0 6026.7 6038.7 6063.8 5905.8 6026.7 6047.9 6124.4 6140.3 5859.6 5861.4 5878.6 5879.3 5903.9 5753.9 6023.1 6026.2 6026.6 6027.4 5706.3 5815.7 5881.1 5891.3 5918.5 5840.9 5900.9 5902.5 5904.6 5905.8 5508.4 5615.0 5764.9 5813.9 5824.8 5815.4 5841.4 5888.8 5908.9 5913.1 5760.2 5813.7 5830.2 5830.9 5831.9 11:41:24 INFO - 2016-01-25 11:41:24,852 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,852 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:56455.84 Median:40435.10 stddev:118088.21 (292.0%) stddev-sans-first:118345.10 11:41:24 INFO - 2016-01-25 11:41:24,852 DEBUG : BROWSER_OUTPUT: Values: 635.2 642.8 645.6 651.3 658.6 41156.6 41859.0 41916.0 42094.8 42124.6 43835.0 44138.6 44162.3 44289.8 44333.1 8737.1 8851.0 8896.3 8899.0 8933.3 8772.9 8779.9 8795.3 8870.8 8881.2 8772.3 8805.3 8873.8 8880.9 8885.2 8791.8 8822.6 8833.3 8851.2 8866.1 8622.6 8804.5 8809.4 8824.4 8838.4 39370.4 39846.4 39871.4 39900.6 39952.4 3781.9 3885.8 4188.0 4213.2 4333.4 32148.2 32448.2 32510.3 32544.7 32554.5 3600.0 3652.7 3808.6 3853.1 3865.5 281023.0 281251.0 282497.0 282935.0 283634.0 45395.0 46121.0 46291.1 46498.1 64629.0 43947.3 44024.0 44086.6 44105.8 44137.0 15906.1 15918.2 16037.7 16043.3 16062.7 12774.4 12819.2 12922.5 12980.6 12983.8 15406.6 15444.8 15523.0 15594.2 15675.3 6220.0 6253.9 6265.7 6395.9 6397.0 1016.7 1023.9 1049.9 1088.1 1163.3 30040.0 30137.0 30498.5 30504.5 30711.0 1133.9 1167.2 1167.8 1223.3 1291.3 15864.8 15896.4 16012.9 16135.4 16253.4 349371.0 561562.0 574438.0 577633.0 942409.0 58350.0 59184.7 59298.4 59419.1 59521.4 1490.6 1512.4 1518.4 1531.4 1534.0 31836.5 32229.2 32381.9 32652.7 33177.3 50669.0 51148.5 51157.7 51161.2 51349.2 322411.0 323772.0 324278.0 324676.0 324733.0 35282.6 35426.6 35620.1 35760.5 35916.8 47433.8 47859.0 48290.5 48465.3 48655.0 40383.8 40486.4 40940.4 40949.0 41779.6 40004.8 41099.6 43378.8 46887.8 47478.8 39306.4 39787.8 39805.2 39904.4 39952.8 39082.7 40979.6 41150.8 41951.4 42112.6 26689.6 27568.4 27618.7 27842.7 28043.2 11:41:24 INFO - 2016-01-25 11:41:24,852 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,852 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:33128.07 Median:1978.69 stddev:110957.88 (5607.6%) stddev-sans-first:111241.90 11:41:24 INFO - 2016-01-25 11:41:24,852 DEBUG : BROWSER_OUTPUT: Values: 383.3 383.8 384.0 387.7 395.2 16266.6 16836.4 18166.0 18432.5 18481.0 11629.9 11832.8 11902.0 17478.9 17822.2 5026.6 5047.2 5166.9 5167.8 5168.4 5095.1 5393.9 5531.0 5546.4 5555.3 5435.7 5480.5 5499.5 5513.6 5527.5 4740.0 5718.7 5751.4 5752.3 5758.9 5429.4 5522.6 5533.4 5537.9 5551.5 13924.6 14199.9 14222.4 15046.7 22100.0 2152.2 2152.6 2160.8 2214.1 2357.2 10292.6 10506.7 10716.9 12093.9 14043.9 1933.5 1935.7 1940.3 2040.7 2055.6 65621.0 67253.0 68031.0 68663.7 69255.0 10816.8 11013.4 11085.3 11129.8 11150.7 14554.6 14584.9 14614.7 14655.4 14661.4 8045.6 8081.9 8118.7 8174.0 8236.1 7997.7 8014.3 8020.0 8035.5 8067.3 4662.3 4740.1 4741.9 4772.3 4783.0 1735.9 1806.8 1817.3 1973.9 1983.5 463.4 480.2 927.6 1024.9 1119.7 10806.7 11565.9 11656.7 11682.2 11819.2 492.2 515.7 1010.7 1029.8 1072.9 9417.3 9534.1 9574.4 9618.6 9803.3 659580.0 664860.0 681292.0 687135.0 700725.0 88236.0 89120.6 90196.0 90497.1 92872.5 1147.1 1149.2 1189.2 1200.3 1203.2 15574.8 15672.8 15730.5 15732.6 15759.3 35130.3 35499.5 35866.6 36038.5 36899.6 42000.6 42764.6 42940.1 45236.0 45681.5 10281.6 10367.2 10424.4 10468.0 10510.2 13491.4 17724.1 18052.5 18190.0 18404.7 10394.8 14729.9 14913.0 15156.5 15200.8 15187.0 15685.8 16083.9 16214.1 16393.2 14921.8 15645.5 15741.4 15949.8 16176.1 10028.5 10066.7 10113.6 10227.9 10299.6 11255.5 11711.8 15569.7 15726.6 15975.4 11:41:24 INFO - 2016-01-25 11:41:24,852 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,852 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5483.32 Median:6670.65 stddev:2871.01 (43.0%) stddev-sans-first:2863.30 11:41:24 INFO - 2016-01-25 11:41:24,852 DEBUG : BROWSER_OUTPUT: Values: 1479.9 1725.2 1798.2 1858.1 1859.5 6976.6 7152.2 7440.6 7917.3 7919.8 7282.6 7495.8 7550.8 7560.8 7575.0 2226.0 2258.7 2270.1 2278.2 2281.7 2305.3 2326.9 2352.5 2354.2 2360.0 2163.6 2167.8 2175.7 2270.0 2283.9 2190.9 2222.0 2223.9 2239.7 2247.9 2301.2 2315.7 2326.8 2328.0 2331.0 7834.8 7872.7 7877.3 7893.4 7909.6 4624.4 4672.3 4720.5 4724.7 4728.7 2876.7 2971.2 3016.5 3038.9 3049.9 900.1 913.0 913.7 997.0 1000.9 10780.4 10865.7 10896.5 10911.7 10915.4 4219.9 4261.1 4262.5 4297.9 4313.7 9296.1 9378.1 9385.7 9387.8 9405.2 4755.2 4762.5 4766.4 4771.0 4795.1 4233.8 4336.1 4355.1 4368.5 4416.4 3570.0 3589.7 3609.4 3612.2 3616.0 1071.9 1077.4 1085.6 1090.2 1093.5 1187.6 1192.1 1200.1 1447.8 1477.1 7606.4 7656.7 7666.0 7667.2 7668.3 507.5 510.8 512.9 514.3 514.7 5855.6 5855.6 5873.3 5894.5 5907.1 9030.7 9353.5 9373.5 9391.4 9503.2 9290.9 9335.5 9343.7 9373.9 9408.9 7180.6 7309.2 7383.3 7435.7 7444.6 7080.9 7090.6 7091.1 7162.1 7186.9 8183.4 8219.0 8380.2 8387.5 8572.5 8220.9 8431.9 8456.6 8499.1 8579.7 5947.3 6393.2 6933.4 6993.1 6994.8 7521.6 7524.7 7591.3 7624.3 7647.6 7083.1 7198.1 7233.8 7334.3 7347.5 6973.5 7016.3 7067.0 7148.6 7155.1 7126.0 7253.3 7305.2 7311.7 7311.7 6738.1 6754.1 6760.6 6788.0 6794.9 6433.6 6621.8 6637.8 6703.5 6828.4 11:41:24 INFO - 2016-01-25 11:41:24,852 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,853 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5694.71 Median:6485.84 stddev:1697.36 (26.2%) stddev-sans-first:1654.05 11:41:24 INFO - 2016-01-25 11:41:24,854 DEBUG : BROWSER_OUTPUT: Values: 350.6 355.3 361.2 361.6 363.8 6364.6 6390.5 6455.7 6479.8 6494.1 6180.9 6330.2 6352.9 6357.6 6372.1 4842.4 4845.2 4845.9 4849.4 4849.7 4885.9 4900.2 4900.6 4908.8 4911.1 4815.5 4873.2 4881.1 4891.5 4906.1 4913.0 4939.6 4940.0 4943.3 4945.7 4346.6 4351.6 4355.8 4358.8 4362.0 5932.7 6044.7 6062.2 6064.7 6066.6 5734.4 5747.6 5750.3 5756.1 5764.8 6734.9 6770.3 6770.7 6773.4 6793.4 4782.8 4816.3 4819.4 4824.0 4836.4 6889.7 6908.9 7070.3 7074.0 7085.0 4771.5 4810.2 4813.2 4813.4 4816.0 4865.8 4865.8 4866.4 4866.9 4889.0 5536.0 5602.4 5620.2 5635.5 5636.2 6702.9 6762.5 6771.1 6773.5 6776.3 1740.0 1773.9 1779.3 1782.2 1782.8 1197.8 1198.3 1203.4 1211.8 1221.1 6341.0 6513.7 6549.9 6560.6 6584.9 6962.3 6969.3 6995.7 7006.8 7013.3 6428.7 6491.8 6503.9 6518.6 6554.7 3784.4 3794.1 3823.2 3828.8 3834.7 7203.8 7250.0 7256.5 7257.7 7269.0 6991.2 7113.5 7141.3 7149.3 7180.1 7238.0 7252.3 7253.6 7255.9 7256.7 7009.7 7013.8 7021.6 7027.9 7029.2 6760.4 6837.6 6852.5 6883.9 6886.9 7177.5 7213.5 7230.6 7235.0 7246.6 4944.6 4976.3 4984.7 4986.7 5009.8 6906.4 6938.6 6988.0 6997.8 7021.6 6830.0 6893.9 6914.6 6937.3 6938.9 6857.5 6882.2 6895.1 6898.6 6916.0 6641.4 6759.7 6762.4 6766.4 6768.8 6896.9 6932.5 6939.7 6945.6 6949.1 6579.2 6655.1 6684.1 6689.8 6710.5 11:41:24 INFO - 2016-01-25 11:41:24,854 DEBUG : BROWSER_OUTPUT: 11:41:24 INFO - 2016-01-25 11:41:24,854 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15163.06 Median:50540.12 stddev:18063.71 (35.7%) stddev-sans-first:18082.25 11:41:24 INFO - 2016-01-25 11:41:24,854 DEBUG : BROWSER_OUTPUT: Values: 815.4 930.1 950.7 961.0 962.8 13630.7 13761.4 13764.2 13813.9 13919.2 14388.9 14389.7 14433.4 14464.7 14485.5 887.0 897.2 917.0 918.3 923.4 901.9 901.9 902.6 903.8 908.9 966.0 967.6 967.9 970.2 971.9 949.6 957.1 959.1 959.8 961.8 696.9 704.9 706.3 711.1 712.3 14948.6 15115.8 15123.7 15125.7 15126.4 12158.7 12218.3 13016.0 13362.5 13740.5 10689.8 10731.1 10871.7 11357.9 11841.8 3861.9 3875.7 3909.5 3936.8 3948.0 49750.3 49867.0 50042.5 50262.5 50548.2 9434.2 9459.5 9463.8 9880.0 10530.1 18969.8 19068.4 19099.9 19117.5 19129.1 8351.0 8366.2 8390.9 8441.2 8619.5 4402.1 4549.7 4566.9 4575.9 4845.3 3270.7 3293.1 3295.3 3301.1 3304.7 544.2 549.6 553.6 563.2 563.7 695.4 706.4 714.3 738.7 741.5 9077.9 9675.1 9729.8 9830.9 9860.5 686.7 711.2 746.8 775.2 782.6 4446.8 4498.9 4608.3 4632.2 4672.7 64337.0 66245.3 66441.0 66732.0 67119.0 57331.3 58058.7 58364.7 58710.0 58740.4 52260.5 52561.7 52799.0 53303.7 53506.0 8762.2 8781.4 9053.8 9382.9 9435.7 40236.0 40517.6 40562.2 40569.6 43036.6 50532.0 50601.5 50926.5 51047.0 51142.2 10223.4 11524.1 12055.0 12104.0 12353.2 13116.4 13167.0 13612.9 13711.7 14116.5 10602.2 10876.8 10917.5 10954.0 10958.4 10836.1 11050.6 11723.8 12061.7 12220.2 9977.9 11968.0 12108.8 12382.8 12642.6 9256.2 9312.3 9521.3 9571.0 10218.9 10360.8 10455.7 10474.3 10599.9 11058.8 11:41:24 INFO - 2016-01-25 11:41:24,854 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:41:24 INFO - 2016-01-25 11:41:24,854 DEBUG : BROWSER_OUTPUT: 11:41:25 INFO - 2016-01-25 11:41:25,401 INFO : Browser exited with error code: 0 11:41:25 INFO - 2016-01-25 11:41:25,420 INFO : Completed test dromaeo_css (00:18:27) 11:41:25 INFO - 2016-01-25 11:41:25,420 INFO : Starting test kraken 11:41:25 INFO - 2016-01-25 11:41:25,420 DEBUG : operating with platform_type : linux_ 11:41:25 INFO - 2016-01-25 11:41:25,420 INFO : Initialising browser for kraken test... 11:41:25 INFO - 2016-01-25 11:41:25,426 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxAZ72p/profile http://localhost:34091/getInfo.html 11:41:28 INFO - 2016-01-25 11:41:28,636 DEBUG : BROWSER_OUTPUT: 11:41:28 INFO - 2016-01-25 11:41:28,636 DEBUG : BROWSER_OUTPUT: (process:337): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:41:29 INFO - 2016-01-25 11:41:29,419 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:41:29 INFO - 2016-01-25 11:41:29,419 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:41:29 INFO - 2016-01-25 11:41:29,419 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:41:29 INFO - 2016-01-25 11:41:29,419 DEBUG : BROWSER_OUTPUT: __metrics 11:41:30 INFO - 2016-01-25 11:41:30,337 INFO : Browser initialized. 11:41:30 INFO - 2016-01-25 11:41:30,337 INFO : Running cycle 1/1 for kraken test... 11:41:30 INFO - 2016-01-25 11:41:30,338 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxAZ72p/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:41:31 INFO - 2016-01-25 11:41:31,731 DEBUG : BROWSER_OUTPUT: 11:41:31 INFO - 2016-01-25 11:41:31,732 DEBUG : BROWSER_OUTPUT: (process:451): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:41:42 INFO - 2016-01-25 11:41:42,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 136028160 11:41:42 INFO - 2016-01-25 11:41:42,235 DEBUG : BROWSER_OUTPUT: 11:41:44 INFO - 2016-01-25 11:41:44,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34091/tests/kraken/driver.html?testName=audio-beat-detection) 11:41:45 INFO - 2016-01-25 11:41:45,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 137076736 11:41:45 INFO - 2016-01-25 11:41:45,315 DEBUG : BROWSER_OUTPUT: 11:41:47 INFO - 2016-01-25 11:41:47,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34091/tests/kraken/driver.html?testName=audio-dft) 11:41:48 INFO - 2016-01-25 11:41:48,505 DEBUG : BROWSER_OUTPUT: RSS: Main: 137539584 11:41:48 INFO - 2016-01-25 11:41:48,505 DEBUG : BROWSER_OUTPUT: 11:41:51 INFO - 2016-01-25 11:41:51,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34091/tests/kraken/driver.html?testName=audio-fft) 11:41:51 INFO - 2016-01-25 11:41:51,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 137584640 11:41:51 INFO - 2016-01-25 11:41:51,914 DEBUG : BROWSER_OUTPUT: 11:41:53 INFO - 2016-01-25 11:41:53,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34091/tests/kraken/driver.html?testName=audio-oscillator) 11:41:54 INFO - 2016-01-25 11:41:54,507 DEBUG : BROWSER_OUTPUT: RSS: Main: 137809920 11:41:54 INFO - 2016-01-25 11:41:54,507 DEBUG : BROWSER_OUTPUT: 11:41:56 INFO - 2016-01-25 11:41:56,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34091/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:41:57 INFO - 2016-01-25 11:41:57,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 137785344 11:41:57 INFO - 2016-01-25 11:41:57,271 DEBUG : BROWSER_OUTPUT: 11:42:00 INFO - 2016-01-25 11:42:00,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34091/tests/kraken/driver.html?testName=imaging-darkroom) 11:42:00 INFO - 2016-01-25 11:42:00,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 139096064 11:42:00 INFO - 2016-01-25 11:42:00,852 DEBUG : BROWSER_OUTPUT: 11:42:04 INFO - 2016-01-25 11:42:04,173 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34091/tests/kraken/driver.html?testName=imaging-desaturate) 11:42:04 INFO - 2016-01-25 11:42:04,755 DEBUG : BROWSER_OUTPUT: RSS: Main: 138899456 11:42:04 INFO - 2016-01-25 11:42:04,755 DEBUG : BROWSER_OUTPUT: 11:42:07 INFO - 2016-01-25 11:42:07,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34091/tests/kraken/driver.html?testName=json-parse-financial) 11:42:08 INFO - 2016-01-25 11:42:08,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 138268672 11:42:08 INFO - 2016-01-25 11:42:08,131 DEBUG : BROWSER_OUTPUT: 11:42:09 INFO - 2016-01-25 11:42:09,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34091/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:42:10 INFO - 2016-01-25 11:42:10,272 DEBUG : BROWSER_OUTPUT: RSS: Main: 138919936 11:42:10 INFO - 2016-01-25 11:42:10,272 DEBUG : BROWSER_OUTPUT: 11:42:12 INFO - 2016-01-25 11:42:12,034 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34091/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:42:12 INFO - 2016-01-25 11:42:12,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 138121216 11:42:12 INFO - 2016-01-25 11:42:12,648 DEBUG : BROWSER_OUTPUT: 11:42:14 INFO - 2016-01-25 11:42:14,693 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34091/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:42:15 INFO - 2016-01-25 11:42:15,279 DEBUG : BROWSER_OUTPUT: RSS: Main: 138649600 11:42:15 INFO - 2016-01-25 11:42:15,279 DEBUG : BROWSER_OUTPUT: 11:42:17 INFO - 2016-01-25 11:42:17,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34091/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:42:18 INFO - 2016-01-25 11:42:18,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 138428416 11:42:18 INFO - 2016-01-25 11:42:18,290 DEBUG : BROWSER_OUTPUT: 11:42:20 INFO - 2016-01-25 11:42:20,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34091/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:42:21 INFO - 2016-01-25 11:42:21,466 DEBUG : BROWSER_OUTPUT: RSS: Main: 138543104 11:42:21 INFO - 2016-01-25 11:42:21,467 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,136 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34091/tests/kraken/driver.html?testName=ai-astar) 11:42:23 INFO - 2016-01-25 11:42:23,380 DEBUG : BROWSER_OUTPUT: RSS: Main: 140095488 11:42:23 INFO - 2016-01-25 11:42:23,380 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,383 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:42:23 INFO - 2016-01-25 11:42:23,383 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:42:23 INFO - 2016-01-25 11:42:23,384 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:42:23 INFO - 2016-01-25 11:42:23,384 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:42:23 INFO - 2016-01-25 11:42:23,384 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;106;113;111;111;120;112;112;111;112 11:42:23 INFO - 2016-01-25 11:42:23,384 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;126;150;166;124;146;159;128;157;126 11:42:23 INFO - 2016-01-25 11:42:23,384 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;162;162;165;161;161;161;164;162 11:42:23 INFO - 2016-01-25 11:42:23,384 DEBUG : BROWSER_OUTPUT: |3;audio-fft;80;72;73;154;74;73;73;72;153;74 11:42:23 INFO - 2016-01-25 11:42:23,384 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;141;92;93;92;138;93;92;138 11:42:23 INFO - 2016-01-25 11:42:23,384 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;109;111 11:42:23 INFO - 2016-01-25 11:42:23,385 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;146;146;147;147;147;147;146 11:42:23 INFO - 2016-01-25 11:42:23,385 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;101;97;96;96;96;97;96;95;95 11:42:23 INFO - 2016-01-25 11:42:23,385 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;58;57;59;60;58;59;60;55;56 11:42:23 INFO - 2016-01-25 11:42:23,385 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;65;65;64;64;64;64;63 11:42:23 INFO - 2016-01-25 11:42:23,385 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;79;89;82;89;89;82;90;82;82;81 11:42:23 INFO - 2016-01-25 11:42:23,385 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;115;122;114;118;116;121;126;127;120;117 11:42:23 INFO - 2016-01-25 11:42:23,385 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;152;154;150;148;156;151;160;145;163 11:42:23 INFO - 2016-01-25 11:42:23,385 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;65;68;65;65;66;64;66;66;67 11:42:23 INFO - 2016-01-25 11:42:23,385 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:42:23 INFO - 2016-01-25 11:42:23,385 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:42:23 INFO - 2016-01-25 11:42:23,385 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,704 11:42:23 INFO - 2016-01-25 11:42:23,385 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:42:23 INFO - 2016-01-25 11:42:23,385 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750943381__endTimestamp 11:42:23 INFO - 2016-01-25 11:42:23,385 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,389 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:42:23 INFO - 2016-01-25 11:42:23,389 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:42:23 INFO - 2016-01-25 11:42:23,389 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,389 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:3.53 (3.2%) stddev-sans-first:3.61 11:42:23 INFO - 2016-01-25 11:42:23,389 DEBUG : BROWSER_OUTPUT: Values: 115.0 106.0 113.0 111.0 111.0 120.0 112.0 112.0 111.0 112.0 11:42:23 INFO - 2016-01-25 11:42:23,389 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,389 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.10 Median:149.50 stddev:15.77 (10.6%) stddev-sans-first:16.58 11:42:23 INFO - 2016-01-25 11:42:23,389 DEBUG : BROWSER_OUTPUT: Values: 149.0 126.0 150.0 166.0 124.0 146.0 159.0 128.0 157.0 126.0 11:42:23 INFO - 2016-01-25 11:42:23,389 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,389 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:1.37 (0.8%) stddev-sans-first:1.45 11:42:23 INFO - 2016-01-25 11:42:23,389 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 162.0 162.0 165.0 161.0 161.0 161.0 164.0 162.0 11:42:23 INFO - 2016-01-25 11:42:23,389 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,390 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.80 Median:73.00 stddev:33.65 (46.1%) stddev-sans-first:35.51 11:42:23 INFO - 2016-01-25 11:42:23,390 DEBUG : BROWSER_OUTPUT: Values: 80.0 72.0 73.0 154.0 74.0 73.0 73.0 72.0 153.0 74.0 11:42:23 INFO - 2016-01-25 11:42:23,390 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,390 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.40 Median:92.00 stddev:22.52 (24.5%) stddev-sans-first:23.27 11:42:23 INFO - 2016-01-25 11:42:23,390 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 141.0 92.0 93.0 92.0 138.0 93.0 92.0 138.0 11:42:23 INFO - 2016-01-25 11:42:23,390 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,390 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 11:42:23 INFO - 2016-01-25 11:42:23,390 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 111.0 11:42:23 INFO - 2016-01-25 11:42:23,390 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,390 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:42:23 INFO - 2016-01-25 11:42:23,391 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 146.0 11:42:23 INFO - 2016-01-25 11:42:23,391 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,391 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.72 (1.8%) stddev-sans-first:1.81 11:42:23 INFO - 2016-01-25 11:42:23,391 DEBUG : BROWSER_OUTPUT: Values: 96.0 101.0 97.0 96.0 96.0 96.0 97.0 96.0 95.0 95.0 11:42:23 INFO - 2016-01-25 11:42:23,391 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,391 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:58.20 Median:59.00 stddev:1.75 (3.0%) stddev-sans-first:1.73 11:42:23 INFO - 2016-01-25 11:42:23,391 DEBUG : BROWSER_OUTPUT: Values: 60.0 58.0 57.0 59.0 60.0 58.0 59.0 60.0 55.0 56.0 11:42:23 INFO - 2016-01-25 11:42:23,392 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,392 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 11:42:23 INFO - 2016-01-25 11:42:23,392 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 65.0 65.0 64.0 64.0 64.0 64.0 63.0 11:42:23 INFO - 2016-01-25 11:42:23,392 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,392 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:85.50 stddev:4.20 (4.9%) stddev-sans-first:3.95 11:42:23 INFO - 2016-01-25 11:42:23,392 DEBUG : BROWSER_OUTPUT: Values: 79.0 89.0 82.0 89.0 89.0 82.0 90.0 82.0 82.0 81.0 11:42:23 INFO - 2016-01-25 11:42:23,393 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,393 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:120.50 stddev:4.45 (3.7%) stddev-sans-first:4.40 11:42:23 INFO - 2016-01-25 11:42:23,393 DEBUG : BROWSER_OUTPUT: Values: 115.0 122.0 114.0 118.0 116.0 121.0 126.0 127.0 120.0 117.0 11:42:23 INFO - 2016-01-25 11:42:23,393 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,393 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.80 Median:153.00 stddev:7.02 (4.6%) stddev-sans-first:5.72 11:42:23 INFO - 2016-01-25 11:42:23,393 DEBUG : BROWSER_OUTPUT: Values: 139.0 152.0 154.0 150.0 148.0 156.0 151.0 160.0 145.0 163.0 11:42:23 INFO - 2016-01-25 11:42:23,394 DEBUG : BROWSER_OUTPUT: 11:42:23 INFO - 2016-01-25 11:42:23,394 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 11:42:23 INFO - 2016-01-25 11:42:23,394 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 68.0 65.0 65.0 66.0 64.0 66.0 66.0 67.0 11:42:23 INFO - 2016-01-25 11:42:23,394 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:42:23 INFO - 2016-01-25 11:42:23,394 DEBUG : BROWSER_OUTPUT: 11:42:24 INFO - 2016-01-25 11:42:24,217 INFO : Browser exited with error code: 0 11:42:24 INFO - 2016-01-25 11:42:24,265 INFO : Completed test kraken (00:00:58) 11:42:24 INFO - 2016-01-25 11:42:24,265 INFO : Starting test v8_7 11:42:24 INFO - 2016-01-25 11:42:24,266 DEBUG : operating with platform_type : linux_ 11:42:24 INFO - 2016-01-25 11:42:24,266 INFO : Initialising browser for v8_7 test... 11:42:24 INFO - 2016-01-25 11:42:24,272 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSi5iBx/profile http://localhost:34091/getInfo.html 11:42:27 INFO - 2016-01-25 11:42:27,554 DEBUG : BROWSER_OUTPUT: 11:42:27 INFO - 2016-01-25 11:42:27,555 DEBUG : BROWSER_OUTPUT: (process:764): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:42:28 INFO - 2016-01-25 11:42:28,377 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:42:28 INFO - 2016-01-25 11:42:28,378 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:42:28 INFO - 2016-01-25 11:42:28,378 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:42:28 INFO - 2016-01-25 11:42:28,378 DEBUG : BROWSER_OUTPUT: __metrics 11:42:29 INFO - 2016-01-25 11:42:29,301 INFO : Browser initialized. 11:42:29 INFO - 2016-01-25 11:42:29,301 INFO : Running cycle 1/1 for v8_7 test... 11:42:29 INFO - 2016-01-25 11:42:29,302 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSi5iBx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:42:30 INFO - 2016-01-25 11:42:30,516 DEBUG : BROWSER_OUTPUT: 11:42:30 INFO - 2016-01-25 11:42:30,517 DEBUG : BROWSER_OUTPUT: (process:886): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 11:42:41 INFO - 2016-01-25 11:42:41,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 135651328 11:42:41 INFO - 2016-01-25 11:42:41,020 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,427 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34091/tests/v8_7/run.html (next: http://localhost:34091/tests/v8_7/run.html) 11:43:02 INFO - 2016-01-25 11:43:02,677 DEBUG : BROWSER_OUTPUT: RSS: Main: 136060928 11:43:02 INFO - 2016-01-25 11:43:02,677 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,677 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:43:02 INFO - 2016-01-25 11:43:02,677 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:43:02 INFO - 2016-01-25 11:43:02,678 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:43:02 INFO - 2016-01-25 11:43:02,678 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:43:02 INFO - 2016-01-25 11:43:02,678 DEBUG : BROWSER_OUTPUT: |0;Richards;166.44474034620507 11:43:02 INFO - 2016-01-25 11:43:02,678 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.0843776106934 11:43:02 INFO - 2016-01-25 11:43:02,678 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 11:43:02 INFO - 2016-01-25 11:43:02,679 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5202.072538860104 11:43:02 INFO - 2016-01-25 11:43:02,679 DEBUG : BROWSER_OUTPUT: |4;RayTrace;896.8609865470852 11:43:02 INFO - 2016-01-25 11:43:02,679 DEBUG : BROWSER_OUTPUT: |5;Earley;548.5463521667581 11:43:02 INFO - 2016-01-25 11:43:02,679 DEBUG : BROWSER_OUTPUT: |6;Boyer;10923.91304347826 11:43:02 INFO - 2016-01-25 11:43:02,679 DEBUG : BROWSER_OUTPUT: |7;RegExp;24000 11:43:02 INFO - 2016-01-25 11:43:02,680 DEBUG : BROWSER_OUTPUT: |8;Splay;517.063081695967 11:43:02 INFO - 2016-01-25 11:43:02,680 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 11:43:02 INFO - 2016-01-25 11:43:02,680 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:43:02 INFO - 2016-01-25 11:43:02,680 DEBUG : BROWSER_OUTPUT: __startTimestamp1453750982676__endTimestamp 11:43:02 INFO - 2016-01-25 11:43:02,680 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,681 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:43:02 INFO - 2016-01-25 11:43:02,681 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:43:02 INFO - 2016-01-25 11:43:02,681 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,681 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.44 Median:166.44 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,681 DEBUG : BROWSER_OUTPUT: Values: 166.4 11:43:02 INFO - 2016-01-25 11:43:02,681 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,682 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.08 Median:167.08 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,682 DEBUG : BROWSER_OUTPUT: Values: 167.1 11:43:02 INFO - 2016-01-25 11:43:02,682 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,683 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,683 DEBUG : BROWSER_OUTPUT: Values: 278.6 11:43:02 INFO - 2016-01-25 11:43:02,684 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,684 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5202.07 Median:5202.07 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,684 DEBUG : BROWSER_OUTPUT: Values: 5202.1 11:43:02 INFO - 2016-01-25 11:43:02,684 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,684 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:896.86 Median:896.86 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,685 DEBUG : BROWSER_OUTPUT: Values: 896.9 11:43:02 INFO - 2016-01-25 11:43:02,685 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,685 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:548.55 Median:548.55 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,685 DEBUG : BROWSER_OUTPUT: Values: 548.5 11:43:02 INFO - 2016-01-25 11:43:02,685 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,685 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10923.91 Median:10923.91 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,685 DEBUG : BROWSER_OUTPUT: Values: 10923.9 11:43:02 INFO - 2016-01-25 11:43:02,685 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,685 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24000.00 Median:24000.00 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,685 DEBUG : BROWSER_OUTPUT: Values: 24000.0 11:43:02 INFO - 2016-01-25 11:43:02,686 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,686 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:517.06 Median:517.06 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,686 DEBUG : BROWSER_OUTPUT: Values: 517.1 11:43:02 INFO - 2016-01-25 11:43:02,686 DEBUG : BROWSER_OUTPUT: 11:43:02 INFO - 2016-01-25 11:43:02,686 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 11:43:02 INFO - 2016-01-25 11:43:02,686 DEBUG : BROWSER_OUTPUT: Values: 4835.7 11:43:02 INFO - 2016-01-25 11:43:02,686 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:43:02 INFO - 2016-01-25 11:43:02,686 DEBUG : BROWSER_OUTPUT: 11:43:03 INFO - 2016-01-25 11:43:03,445 INFO : Browser exited with error code: 0 11:43:03 INFO - 2016-01-25 11:43:03,464 INFO : Completed test v8_7 (00:00:39) 11:43:03 INFO - 2016-01-25 11:43:03,715 INFO : Completed test suite (00:20:06) 11:43:03 INFO - 2016-01-25 11:43:03,715 DEBUG : Working with test: dromaeo_css 11:43:03 INFO - 2016-01-25 11:43:03,715 DEBUG : Generating results file: dromaeo_css 11:43:03 INFO - 2016-01-25 11:43:03,716 DEBUG : Working with test: kraken 11:43:03 INFO - 2016-01-25 11:43:03,717 DEBUG : Generating results file: kraken 11:43:03 INFO - 2016-01-25 11:43:03,717 INFO : javascript benchmark 11:43:03 INFO - 2016-01-25 11:43:03,717 DEBUG : Working with test: v8_7 11:43:03 INFO - 2016-01-25 11:43:03,717 DEBUG : Generating results file: v8_7 11:43:03 INFO - 2016-01-25 11:43:03,718 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:43:03 INFO - 2016-01-25 11:43:03,776 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 11:43:03 INFO - 2016-01-25 11:43:03,776 DEBUG : process_Request line: dromaeo_css 7307.88 graph.html#tests=[[72,52,43]] 11:43:03 INFO - 2016-01-25 11:43:03,776 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:43:03 INFO - 2016-01-25 11:43:03,808 DEBUG : process_Request line: kraken 1510.60 graph.html#tests=[[232,52,43]] 11:43:03 INFO - 2016-01-25 11:43:03,809 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:43:03 INFO - 2016-01-25 11:43:03,839 DEBUG : process_Request line: v8_7 23335.58 graph.html#tests=[[230,52,43]] 11:43:03 INFO - 2016-01-25 11:43:03,840 INFO : javascript benchmark 11:43:03 INFO - 2016-01-25 11:43:03,844 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3225.3710526447344, 3283.080737393531, 3291.9835400822994, 3310.222097807016, 3321.070100371895, 5493.285872836531, 5530.723463826803, 5533.418991005947, 5549.223108764776, 5551.056320425528, 5500.559955203584, 5504.256925315081, 5516.834494965157, 5557.694326812024, 5579.995600791855, 5032.220005899091, 5062.645614806965, 5138.820141295056, 5139.12634852076, 5172.043172013189, 4903.215485522317, 5007.924881126786, 5077.035363280965, 5079.085764562377, 5117.795288188468, 5009.524095210949, 5086.542211200991, 5092.821751238707, 5098.821541246057, 5196.740162991835, 5059.16523773577, 5068.949310506885, 5072.315237442954, 5081.491850814908, 5108.565771909392, 4859.0, 4906.950930490685, 4954.7274899880495, 5031.295618613397, 5063.164577844651, 5313.9734301328635, 5340.118880384732, 5356.464353564651, 5422.593305502063, 5424.05079111154, 5961.403859614047, 5984.581079324449, 6003.009503431972, 6041.335453100155, 6049.274087109531, 5755.884882302373, 5848.385919478436, 5921.644701317935, 6033.577649564532, 6073.848153796146, 5566.471185237396, 5566.721663916828, 5577.0, 5595.104783234704, 5595.692236926968, 6025.487833534199, 6031.788887388921, 6033.3966603340195, 6035.909461358083, 6036.0644100164545, 5676.205331253628, 5736.971315143398, 5781.5952883298605, 5806.187133801187, 5833.504152147115, 5865.94134058654, 5895.41045895407, 5914.231149950565, 5933.881322373529, 5983.192269043623, 5680.403557626472, 5872.823815285548, 5901.940980590139, 5910.290765108214, 5935.169076329317, 5829.5044921181325, 5882.23530940975, 5965.194698715618, 5977.133315669291, 6003.189569408161, 4619.0530941156985, 4623.53764623535, 4624.5375462453485, 4630.83792067276, 4650.697704649187, 4005.439238506611, 4091.7135800494275, 4106.815193316308, 4111.362738775495, 4124.8556300529335, 5667.376588575254, 5698.031334673115, 5723.227364305765, 5768.826935191951, 5794.88410231793, 5940.732667029994, 5948.67282299469, 5950.761969521171, 5951.940480595225, 5975.43233392827, 5445.0, 5543.501084902378, 5548.4174161713245, 5674.801381951695, 5687.630304030225, 5092.185250359925, 5139.897202056013, 5142.871428214325, 5145.434002259748, 5245.213218017251, 6166.845828854314, 6196.907046394308, 6197.5351848611535, 6200.751969921243, 6203.410675985774, 5992.43071908168, 6025.969870150621, 6026.728797204224, 6038.728257228523, 6063.818085457443, 5905.793297234748, 6026.668533230539, 6047.879042419215, 6124.448799608057, 6140.263168419819, 5859.648421094577, 5861.35525092231, 5878.617889837147, 5879.323877753942, 5903.940960590339, 5753.8561535961935, 6023.066424704178, 6026.15633811258, 6026.638401695912, 6027.397260274113, 5706.343770466449, 5815.709214539341, 5881.088431293157, 5891.263592050994, 5918.496927761188, 5840.883182336414, 5900.90833195843, 5902.498287645427, 5904.645721256738, 5905.763769449174, 5508.366537848199, 5615.0, 5764.884702305846, 5813.883722325445, 5824.825255242349, 5815.447532484407, 5841.4450627190345, 5888.764449422147, 5908.940910590839, 5913.113033045078, 5760.164776107525, 5813.651180929158, 5830.154627579062, 5830.9416905832095, 5831.854203644943], "unit": "ms", "name": "dojo.html", "value": 5487.331695310136}, {"lowerIsBetter": false, "replicates": [635.2123367024889, 642.7525402719955, 645.5674697952371, 651.2998526583923, 658.5818005566464, 41156.588434115685, 41859.0, 41915.99999999996, 42094.789526052366, 42124.578754212445, 43835.0, 44138.55861441392, 44162.337564936555, 44289.7785511072, 44333.11333773322, 8737.082606326323, 8850.955745221265, 8896.288296936262, 8898.955505222464, 8933.28533717301, 8772.868406973901, 8779.912200878005, 8795.296376289882, 8870.822583548324, 8881.200691937724, 8772.254358379514, 8805.295576353908, 8873.822523549525, 8880.866786998167, 8885.155910188521, 8791.824163516758, 8822.558872056403, 8833.293336533063, 8851.159139881702, 8866.069062748447, 8622.568871556397, 8804.515751633657, 8809.38334316598, 8824.382293239476, 8838.381313308071, 39370.40944385836, 39846.402303965464, 39871.40192897109, 39900.60099399027, 39952.400713989315, 3781.9054523636855, 3885.7668539887695, 4188.036751547131, 4213.157368526307, 4333.393324934512, 32148.19629509281, 32448.188795280308, 32510.349793004007, 32544.6745532544, 32554.511682324784, 3600.0, 3652.689521390685, 3808.5810560838286, 3853.094522787143, 3865.4974853269177, 281023.0, 281251.0, 282497.0, 282934.99999999796, 283634.0, 45395.0, 46121.0, 46291.07417851624, 46498.07003859904, 64629.0, 43947.34078988818, 44024.0, 44086.55913440824, 44105.77947110308, 44137.0, 15906.12516311614, 15918.204089795463, 16037.67924641524, 16043.278052487665, 16062.678746425006, 12774.361281935866, 12819.230846149261, 12922.483100675867, 12980.610581682564, 12983.805242921364, 15406.614834629225, 15444.768328475082, 15523.0, 15594.220288985505, 15675.294611742498, 6220.0, 6253.906191407133, 6265.749370025239, 6395.936040639534, 6396.968015159894, 1016.7051555048953, 1023.8515415264894, 1049.9107575856137, 1088.1403691083956, 1163.30201878872, 30040.0, 30137.0, 30498.542521861746, 30504.54243186354, 30711.0, 1133.886611338876, 1167.1870791392873, 1167.795635763738, 1223.2966044524435, 1291.3285091752236, 15864.841351586567, 15896.364145434285, 16012.919935400249, 16135.435259765853, 16253.431129910396, 349371.0, 561562.0, 574438.0, 577633.0, 942409.0, 58350.0, 59184.70407647934, 59298.40701592929, 59419.108713369336, 59521.40478595245, 1490.5751860719643, 1512.447956495871, 1518.3850540531103, 1531.3568301313253, 1533.9693206135814, 31836.52245216277, 32229.194270143435, 32381.90153478193, 32652.673473264964, 33177.33645327032, 50669.0, 51148.488515114375, 51157.7442112787, 51161.23258151205, 51349.22976155435, 322411.0, 323772.0, 324278.0, 324676.0, 324733.0, 35282.647173527934, 35426.64573354233, 35620.109497262776, 35760.46359304665, 35916.82041589775, 47433.762831185624, 47859.04281914412, 48290.51709483001, 48465.27302090542, 48655.0, 40383.79808100941, 40486.392704110054, 40940.36238550544, 40949.0, 41779.58220417757, 40004.79997599994, 41099.58900410958, 43378.78310608553, 46887.765561171975, 47478.76260618675, 39306.41040384454, 39787.80106099451, 39805.203895922496, 39904.40143397793, 39952.800235998635, 39082.72103571496, 40979.59020409877, 41150.7979804988, 41951.37072943847, 42112.57887421086, 26689.599656005565, 27568.44863102767, 27618.723812761615, 27842.721572784012, 28043.158705238875], "unit": "ms", "name": "ext.html", "value": 19696.426585694524}, {"lowerIsBetter": false, "replicates": [383.3349139243412, 383.75439718580094, 384.04373110953725, 387.6762902976015, 395.2293028594242, 16266.593335166626, 16836.41072562459, 18166.0, 18432.539186520327, 18481.0, 11629.883701162986, 11832.822507662371, 11902.0, 17478.912605436955, 17822.19800108995, 5026.62300327476, 5047.167217409123, 5166.870828229286, 5167.7932882684645, 5168.379794424655, 5095.0574143783515, 5393.865153371177, 5531.0, 5546.417626149257, 5555.2778138841895, 5435.728213589325, 5480.534154596864, 5499.50504454599, 5513.58648101392, 5527.474889885454, 4740.0, 5718.6568805871575, 5751.424857514257, 5752.28096487939, 5758.856028599276, 5429.429909859447, 5522.6134170608075, 5533.446655334475, 5537.916931246034, 5551.528120109796, 13924.58226253214, 14199.935004874573, 14222.431102755878, 15046.699066018728, 22100.0, 2152.2467136502255, 2152.630160773632, 2160.79472450117, 2214.136486770161, 2357.198552492144, 10292.588296468133, 10506.737331566696, 10716.892831071667, 12093.911547960726, 14043.929780351134, 1933.5359513716608, 1935.6612592796205, 1940.3111895277113, 2040.6938959156098, 2055.629986602411, 65621.0, 67253.0, 68031.0, 68663.65668171678, 69255.0, 10816.78366432667, 11013.449327533592, 11085.279456835442, 11129.833052504218, 11150.721231969103, 14554.636134096732, 14584.854151458561, 14614.707705846036, 14655.413783448756, 14661.413543458355, 8045.5574943377505, 8081.919180808117, 8118.660421030582, 8173.959130204311, 8236.052853921756, 7997.680092796223, 8014.278714915686, 8020.0, 8035.477693949874, 8067.273945344829, 4662.32396302541, 4740.051989602093, 4741.881452963704, 4772.284157376352, 4783.019481006385, 1735.947921562355, 1806.8102849200907, 1817.3275887921554, 1973.8618296719092, 1983.5239542509983, 463.4461818127306, 480.1741005470585, 927.5825878354767, 1024.8580466824374, 1119.7200699825044, 10806.675799726021, 11565.884341156481, 11656.650300491, 11682.182247242612, 11819.172657914036, 492.1608657239398, 515.6725479320659, 1010.7422607235108, 1029.7785976015193, 1072.8658917635296, 9417.340786145041, 9534.141927226445, 9574.377665451724, 9618.567164477616, 9803.313768036169, 659580.0, 664860.0, 681292.0, 687135.0, 700725.0, 88236.0, 89120.55439722759, 90196.0, 90497.09502905018, 92872.53563732139, 1147.05941128274, 1149.1668540308376, 1189.191349882071, 1200.291827821572, 1203.199872085071, 15574.766378504104, 15672.764908526153, 15730.528084157493, 15732.60668483297, 15759.290831912362, 35130.297394051464, 35499.467507987916, 35866.64133358633, 36038.45942310815, 36899.63100368962, 42000.57999419967, 42764.572354277305, 42940.141197176505, 45236.0, 45681.54318456773, 10281.588736450758, 10367.170626350025, 10424.374537527772, 10468.0, 10510.211734120125, 13491.392887320291, 17724.113794309975, 18052.458426247234, 18190.0, 18404.723929141343, 10394.844077338696, 14729.92635036818, 14913.0, 15156.545303640467, 15200.771988419961, 15187.0, 15685.843141568439, 16083.919580402024, 16214.10822404779, 16393.18034098314, 14921.776173357192, 15645.530634080997, 15741.370345186064, 15949.760753588938, 16176.110313932846, 10028.548715307974, 10066.748331291776, 10113.64602238918, 10227.94886025565, 10299.588016479256, 11255.549778008788, 11711.765764684487, 15569.68860622804, 15726.606834829221, 15975.440859569859], "unit": "ms", "name": "jquery.html", "value": 9040.886075757657}, {"lowerIsBetter": false, "replicates": [1479.9408023679052, 1725.2064050536753, 1798.1908141336403, 1858.0616788521795, 1859.460756380649, 6976.616286104262, 7152.213256541776, 7440.5535667859895, 7917.3270272026875, 7919.841603167941, 7282.56304621723, 7495.812604684886, 7550.773476795691, 7560.848783024337, 7574.962125189366, 2225.9777402225973, 2258.7176602924633, 2270.0919632147193, 2278.2254033628565, 2281.7147856517936, 2305.250793492113, 2326.906923723049, 2352.529494101178, 2354.211339201361, 2359.9882000589973, 2163.642998905179, 2167.8265738740943, 2175.662772270293, 2269.965950510744, 2283.8515496492673, 2190.8575942563684, 2222.022310183522, 2223.9110435582556, 2239.73123225214, 2247.932232189705, 2301.2290882554366, 2315.6758053872472, 2326.7789559991775, 2328.0455013444575, 2330.953380932389, 7834.804129896741, 7872.724454644117, 7877.330426913719, 7893.447458677895, 7909.644066017043, 4624.3757092792375, 4672.275797251432, 4720.480747117815, 4724.692894961817, 4728.716277023355, 2876.6548014238424, 2971.242333205019, 3016.5324374721954, 3038.893638722634, 3049.8780048798244, 900.1313732248411, 913.0413066280379, 913.7258822353334, 996.9551370188359, 1000.8798944126679, 10780.353178809297, 10865.67402977904, 10896.455177241107, 10911.727206819814, 10915.399653019082, 4219.894502637459, 4261.105167914772, 4262.531121576624, 4297.914041719148, 4313.654907607384, 9296.116868897443, 9378.109079637423, 9385.718428447157, 9387.765305867408, 9405.247580193569, 4755.239161734106, 4762.499937506581, 4766.356541866873, 4770.976145119253, 4795.112904112751, 4233.767142807175, 4336.089421221515, 4355.128974205171, 4368.5194628590825, 4416.381706561084, 3569.982150089233, 3589.748717589796, 3609.3864043112208, 3612.2233719749856, 3616.0, 1071.892810718922, 1077.4020418667715, 1085.6200329884477, 1090.1932569898217, 1093.4532733633184, 1187.6437068879302, 1192.1059205595802, 1200.0759415250209, 1447.7828325751223, 1477.106350657858, 7606.3914886808925, 7656.655450504741, 7665.961670191613, 7667.156612772591, 7668.348190403766, 507.5229284472584, 510.7752588860889, 512.8794733237686, 514.3133916221885, 514.6757542748045, 5855.560832937462, 5855.648661080349, 5873.295204575393, 5894.498967587803, 5907.054871220584, 9030.729078127666, 9353.532323383804, 9373.531323433801, 9391.389559678599, 9503.239740820718, 9290.907090929139, 9335.533223338805, 9343.71968840936, 9373.859392109123, 9408.858867116998, 7180.640967951582, 7309.159446663702, 7383.2985866342615, 7435.739749108755, 7444.59054751983, 7080.858382832417, 7090.645467726697, 7091.11361079865, 7162.104736907887, 7186.892196617159, 8183.386246031452, 8218.958905205436, 8380.20388063133, 8387.496750195009, 8572.52851093196, 8220.917790822015, 8431.915680843113, 8456.577171141542, 8499.065102838558, 8579.65681372763, 5947.3457919627945, 6393.232812062396, 6933.375996160168, 6993.055937448583, 6994.790156295319, 7521.586312752851, 7524.736634217776, 7591.316781489692, 7624.313811756969, 7647.617619119133, 7083.114610673666, 7198.064251647253, 7233.819154520968, 7334.266573342623, 7347.5224110432655, 6973.546719463218, 7016.298370162943, 7067.0, 7148.64256787169, 7155.141383034069, 7126.011537636771, 7253.274672532704, 7305.196428392979, 7311.744088956861, 7311.744088956861, 6738.09035780183, 6754.0881980931945, 6760.560563563353, 6788.049673045876, 6794.93205067943, 6433.646149461824, 6621.834454138492, 6637.800865974028, 6703.497237707289, 6828.419584335387], "unit": "ms", "name": "mootools.html", "value": 4423.752913221554}, {"lowerIsBetter": false, "replicates": [350.56004714083826, 355.2646022732944, 361.1909323116219, 361.6112678870214, 363.7890023786204, 6364.618122912629, 6390.52071094668, 6455.677216139186, 6479.838004049901, 6494.123293355401, 6180.938190618092, 6330.177076979986, 6352.936470635293, 6357.586756860801, 6372.107904893307, 4842.394700662418, 4845.200541910589, 4845.909670324167, 4849.369581954341, 4849.733264670442, 4885.8778530536665, 4900.215965445529, 4900.558949694527, 4908.8281910133155, 4911.140550403683, 4815.518448155191, 4873.1715608346485, 4881.145799485093, 4891.461939186686, 4906.1168989581865, 4913.0, 4939.580135688453, 4940.036692844897, 4943.307936888838, 4945.653804233705, 4346.587074227943, 4351.630111440531, 4355.825766969318, 4358.847440339605, 4362.0, 5932.673702946337, 6044.697765111727, 6062.151298818169, 6064.696765161769, 6066.63600183986, 5734.4265573442735, 5747.568932330092, 5750.338711048241, 5756.079027355603, 5764.798232061899, 6734.8989765153565, 6770.289119642465, 6770.69531871067, 6773.3903948644365, 6793.422559082434, 4782.760861956888, 4816.301636262722, 4819.397575303087, 4824.0, 4836.41962964443, 6889.689963951634, 6908.861822763567, 7070.328318809705, 7073.964630176868, 7084.964575177142, 4771.4512831024185, 4810.158222311082, 4813.181759100961, 4813.350197723333, 4816.0, 4865.781039853215, 4865.8053677853195, 4866.391701037371, 4866.9269960949905, 4888.975555122272, 5536.0, 5602.411746766612, 5620.241267428844, 5635.549156067586, 5636.18275350072, 6702.899456508157, 6762.492813039042, 6771.085903403076, 6773.45812335012, 6776.2546119926765, 1739.956501087483, 1773.873590270162, 1779.2616064333156, 1782.1980108951025, 1782.7860656721018, 1197.7724232395817, 1198.2870192235605, 1203.3562044306254, 1211.7818792617238, 1221.0902877356248, 6341.0, 6513.674316284167, 6549.901751473732, 6560.6063636181025, 6584.86830263392, 6962.268961759044, 6969.2682268361095, 6995.720171193197, 7006.824829379307, 7013.26360732126, 6428.742850286029, 6491.837704057436, 6503.902441463382, 6518.641474718936, 6554.7378104876225, 3784.4323351496946, 3794.1083845296334, 3823.1780167264174, 3828.8277027533827, 3834.6932245420858, 7203.819904502429, 7249.98500209971, 7256.4557658175845, 7257.709691612382, 7268.96365518169, 6991.161060672752, 7113.502054856111, 7141.285871412817, 7149.285071492809, 7180.138383394026, 7237.963810181021, 7252.274772522811, 7253.5647861127445, 7255.854882902312, 7256.6734496947765, 7009.684564194726, 7013.754518591825, 7021.613811240431, 7027.9297207027275, 7029.226785053538, 6760.391564759196, 6837.58974461514, 6852.45180385558, 6883.931160688529, 6886.896696549656, 7177.4616903731385, 7213.495055346076, 7230.602316872622, 7235.0, 7246.6376681164675, 4944.554990050912, 4976.328195693535, 4984.651074424755, 4986.7257300848805, 5009.77456014473, 6906.37842594169, 6938.583684978716, 6988.021676965331, 6997.755078572225, 7021.5787052777, 6830.0, 6893.931060689329, 6914.585124892523, 6937.340952609494, 6938.895916561357, 6857.525631989146, 6882.242953275236, 6895.069165662571, 6898.620575868375, 6915.965420172867, 6641.402273795188, 6759.662016899234, 6762.425193858577, 6766.424853887278, 6768.763093291711, 6896.862062758817, 6932.480063995321, 6939.687714052779, 6945.583265004116, 6949.061876646791, 6579.243387010555, 6655.068290439439, 6684.0642310075655, 6689.832754181184, 6710.496712746466], "unit": "ms", "name": "prototype.html", "value": 5146.271002660699}, {"lowerIsBetter": false, "replicates": [815.4332738746574, 930.1024511346545, 950.6767698982345, 960.9951950240247, 962.817064757696, 13630.659233519167, 13761.380737866795, 13764.242966636832, 13813.930930345334, 13919.164850109, 14388.856111438883, 14389.712205755879, 14433.422663093465, 14464.710705785878, 14485.493007744732, 886.9911300886989, 897.1701176411825, 916.9816603667923, 918.334207699416, 923.376720713519, 901.8557030875062, 901.9052999435063, 902.5803001604253, 903.8237543678986, 908.9454632722025, 965.9613615455409, 967.5984466446452, 967.9419234845897, 970.2141265574871, 971.8542218667186, 949.5679465843094, 957.0572985609169, 959.122403001253, 959.7504648791295, 961.8461046232604, 696.8745625787357, 704.9295070492961, 706.3184027413571, 711.1111111111111, 712.2699233285872, 14948.62628434287, 15115.848841511553, 15123.697526049527, 15125.697486050218, 15126.394944202219, 12158.696032599168, 12218.26690398579, 13015.958723302114, 13362.465501379933, 13740.450381984709, 10689.83965240522, 10731.141508679366, 10871.728206794814, 11357.945714157204, 11841.763164736743, 3861.903452413684, 3875.7286989910717, 3909.4722212501233, 3936.7834769087976, 3947.980260098681, 49750.253746193834, 49867.0, 50042.49957500415, 50262.49737502615, 50548.24177637338, 9434.150926416656, 9459.479728614855, 9463.810723785486, 9879.950600247097, 10530.104941080093, 18969.81030189708, 19068.427947161606, 19099.90450047741, 19117.522061948286, 19129.13918873654, 8351.0, 8366.163383661586, 8390.916090839135, 8441.155884411632, 8619.482831030033, 4402.075564131568, 4549.7042692224895, 4566.908661826745, 4575.931361029588, 4845.297431872359, 3270.689284517967, 3293.094399040283, 3295.340931813599, 3301.059198128522, 3304.6530114337647, 544.1538407775946, 549.5768258440978, 553.6290685240898, 563.2171281918137, 563.6843367714093, 695.3776370148789, 706.4030893894651, 714.3035540348222, 738.7082102569562, 741.4846681556375, 9077.863832042525, 9675.127559258503, 9729.805403891882, 9830.901690983143, 9860.506974651382, 686.7321744519642, 711.164381851333, 746.8170298276957, 775.2324699684727, 782.62042909189, 4446.822127114944, 4498.887527811831, 4608.28571571407, 4632.2125238709505, 4672.696274742131, 64337.0, 66245.33754662488, 66441.0, 66732.0, 67119.0, 57331.2734672245, 58058.7097064512, 58364.708176458844, 58710.0, 58740.412595874346, 52260.47739522632, 52561.7371913138, 52799.0, 53303.73348133157, 53506.0, 8762.211400973943, 8781.429207101519, 9053.773655658399, 9382.859257111013, 9435.716928492157, 40236.0, 40517.59482405256, 40562.18875622412, 40569.59430405776, 43036.569634303254, 50532.0, 50601.49398505968, 50926.490735093656, 51047.0, 51142.23286650777, 10223.386596804216, 11524.078073754246, 12055.0, 12104.0, 12353.197042192229, 13116.409761560562, 13167.0, 13612.930540681735, 13711.657208569466, 14116.50592229267, 10602.151827853908, 10876.782464350827, 10917.508712107816, 10954.0, 10958.39728814891, 10836.133109351076, 11050.557977680803, 11723.824142637697, 12061.698457538281, 12220.205686630341, 9977.900220997697, 11968.013685686805, 12108.75782484363, 12382.81425778632, 12642.55751048709, 9256.213221876216, 9312.301577381588, 9521.2859035574, 9570.95214523923, 10218.948905255425, 10360.792784144123, 10455.738606534898, 10474.266801323834, 10599.947000264949, 11058.778824423305], "unit": "ms", "name": "yui.html", "value": 6846.482487893283}], "name": "dromaeo_css", "value": 7307.88244386516}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 106.0, 113.0, 111.0, 111.0, 120.0, 112.0, 112.0, 111.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [149.0, 126.0, 150.0, 166.0, 124.0, 146.0, 159.0, 128.0, 157.0, 126.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.1}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 162.0, 162.0, 165.0, 161.0, 161.0, 161.0, 164.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.1}, {"lowerIsBetter": true, "replicates": [80.0, 72.0, 73.0, 154.0, 74.0, 73.0, 73.0, 72.0, 153.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 89.8}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 141.0, 92.0, 93.0, 92.0, 138.0, 93.0, 92.0, 138.0], "unit": "ms", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 101.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [60.0, 58.0, 57.0, 59.0, 60.0, 58.0, 59.0, 60.0, 55.0, 56.0], "unit": "ms", "name": "json-parse-financial", "value": 58.2}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 65.0, 65.0, 64.0, 64.0, 64.0, 64.0, 63.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [79.0, 89.0, 82.0, 89.0, 89.0, 82.0, 90.0, 82.0, 82.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [115.0, 122.0, 114.0, 118.0, 116.0, 121.0, 126.0, 127.0, 120.0, 117.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.6}, {"lowerIsBetter": true, "replicates": [139.0, 152.0, 154.0, 150.0, 148.0, 156.0, 151.0, 160.0, 145.0, 163.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 151.8}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 68.0, 65.0, 65.0, 66.0, 64.0, 66.0, 66.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1510.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.44474034620507], "unit": "score", "name": "Richards", "value": 212.09441600000005}, {"lowerIsBetter": false, "replicates": [167.0843776106934], "unit": "score", "name": "DeltaBlue", "value": 395.71623000000017}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5202.072538860104], "unit": "score", "name": "Decrypt", "value": 51.16825996015938}, {"lowerIsBetter": false, "replicates": [896.8609865470852], "unit": "score", "name": "RayTrace", "value": 825.0877350000001}, {"lowerIsBetter": false, "replicates": [548.5463521667581], "unit": "score", "name": "Earley", "value": 1214.9620489999998}, {"lowerIsBetter": false, "replicates": [10923.91304347826], "unit": "score", "name": "Boyer", "value": 61.0095482587065}, {"lowerIsBetter": false, "replicates": [24000.0], "unit": "score", "name": "RegExp", "value": 37.95770833333335}, {"lowerIsBetter": false, "replicates": [517.063081695967], "unit": "score", "name": "Splay", "value": 157.6035939999999}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 23335.582422282427}]} 11:43:03 INFO - RETURN: dromaeo_css: 7307.88 11:43:03 INFO - RETURN: kraken: 1510.60 11:43:03 INFO - RETURN: v8_7: 23335.58 11:43:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23335.58"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1510.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7307.88"}}} 11:43:03 INFO - Return code: 0 11:43:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:43:04 INFO - # TBPL SUCCESS # 11:43:04 INFO - Running post-action listener: _resource_record_post_action 11:43:04 INFO - Running post-run listener: _resource_record_post_run 11:43:05 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 515792896; Read time: 12; Write time: 479336 11:43:05 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 235724800; Read time: 0; Write time: 319644 11:43:05 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 4096; Write bytes: 264679424; Read time: 12; Write time: 134084 11:43:05 INFO - Running post-run listener: _upload_blobber_files 11:43:05 INFO - Blob upload gear active. 11:43:05 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:43:05 INFO - Copying logs to upload dir... 11:43:05 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1256.708969 ========= master_lag: 0.98 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-01-25 11:43:05.750860) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:05.758886) ========= 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=82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008910 build_url: 'https://queue.taskcluster.net/v1/task/PHQ0c6KXRmi54Td_3VlBEQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:05.785879) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:05.786202) ========= 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=82e07478c745e68b1fe4678a000001bc-1453749726.764026-1037342594 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004722 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 11:43:05.835329) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 11:43:05.838686) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 11:43:06.134535) ========= ========= Total master_lag: 1.22 =========