builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1451301684.64 results: success (0) buildid: 20151228004010 builduid: 8a22b45bf7d44c9193475f2120e91151 revision: 866e6a5e2847194516ab65d71d19fd422842b22e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:24.643322) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:24.643728) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:24.644023) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006281 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:24.685962) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:24.686269) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:24.765552) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:24.765823) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004721 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:24.833202) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:24.833466) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:24.833804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:24.834087) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-28 03:21:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.4M=0s 2015-12-28 03:21:25 (43.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163586 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:25.011586) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:25.011931) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.109260 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:25.134073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-28 03:21:25.134378) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 866e6a5e2847194516ab65d71d19fd422842b22e --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 866e6a5e2847194516ab65d71d19fd422842b22e --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=5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-28 03:21:25,238 truncating revision to first 12 chars 2015-12-28 03:21:25,239 Setting DEBUG logging. 2015-12-28 03:21:25,239 attempt 1/10 2015-12-28 03:21:25,239 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/866e6a5e2847?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-28 03:21:26,068 unpacking tar archive at: mozilla-aurora-866e6a5e2847/testing/mozharness/ program finished with exit code 0 elapsedTime=1.078499 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-28 03:21:26.226670) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:26.226967) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:26.238791) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:26.239067) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-28 03:21:26.239457) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-28 03:21:26.239751) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:21:26 INFO - MultiFileLogger online at 20151228 03:21:26 in /builds/slave/test-pgo 03:21:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:21:26 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:21:26 INFO - {'append_to_log': False, 03:21:26 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:21:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:21:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:21:26 INFO - 'branch': 'Mozilla-Aurora', 03:21:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:21:26 INFO - 'config_files': ('talos/linux_config.py',), 03:21:26 INFO - 'default_actions': ('clobber', 03:21:26 INFO - 'read-buildbot-config', 03:21:26 INFO - 'download-and-extract', 03:21:26 INFO - 'populate-webroot', 03:21:26 INFO - 'create-virtualenv', 03:21:26 INFO - 'install', 03:21:26 INFO - 'run-tests'), 03:21:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:21:26 INFO - 'download_minidump_stackwalk': True, 03:21:26 INFO - 'download_symbols': 'ondemand', 03:21:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:21:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:21:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:21:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:21:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:21:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:21:26 INFO - 'installer_path': 'installer.exe', 03:21:26 INFO - 'log_level': 'info', 03:21:26 INFO - 'log_name': 'talos', 03:21:26 INFO - 'log_to_console': True, 03:21:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:21:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:21:26 INFO - 'opt_config_files': (), 03:21:26 INFO - 'pip_index': False, 03:21:26 INFO - 'sps_profile': False, 03:21:26 INFO - 'sps_profile_interval': 0, 03:21:26 INFO - 'suite': 'dromaeojs-e10s', 03:21:26 INFO - 'system_bits': '64', 03:21:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:21:26 INFO - 'title': 'talos-linux64-ix-024', 03:21:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:21:26 INFO - 'use_talos_json': True, 03:21:26 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:21:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:21:26 INFO - 'work_dir': 'build'} 03:21:26 INFO - ##### 03:21:26 INFO - ##### Running clobber step. 03:21:26 INFO - ##### 03:21:26 INFO - Running pre-action listener: _resource_record_pre_action 03:21:26 INFO - Running main action method: clobber 03:21:26 INFO - rmtree: /builds/slave/test-pgo/build 03:21:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:21:27 INFO - Running post-action listener: _resource_record_post_action 03:21:27 INFO - ##### 03:21:27 INFO - ##### Running read-buildbot-config step. 03:21:27 INFO - ##### 03:21:27 INFO - Running pre-action listener: _resource_record_pre_action 03:21:27 INFO - Running main action method: read_buildbot_config 03:21:27 INFO - Using buildbot properties: 03:21:27 INFO - { 03:21:27 INFO - "properties": { 03:21:27 INFO - "buildnumber": 54, 03:21:27 INFO - "product": "firefox", 03:21:27 INFO - "script_repo_revision": "production", 03:21:27 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:21:27 INFO - "repository": "", 03:21:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:21:27 INFO - "buildid": "20151228004010", 03:21:27 INFO - "slavename": "talos-linux64-ix-024", 03:21:27 INFO - "stage_platform": "linux64-pgo", 03:21:27 INFO - "basedir": "/builds/slave/test-pgo", 03:21:27 INFO - "nightly_build": "True", 03:21:27 INFO - "project": "", 03:21:27 INFO - "platform": "ubuntu64_hw", 03:21:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:21:27 INFO - "slavebuilddir": "test", 03:21:27 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:21:27 INFO - "branch": "mozilla-aurora", 03:21:27 INFO - "repo_path": "releases/mozilla-aurora", 03:21:27 INFO - "pgo_build": "True", 03:21:27 INFO - "builduid": "8a22b45bf7d44c9193475f2120e91151", 03:21:27 INFO - "revision": "866e6a5e2847194516ab65d71d19fd422842b22e" 03:21:27 INFO - }, 03:21:27 INFO - "sourcestamp": { 03:21:27 INFO - "repository": "", 03:21:27 INFO - "hasPatch": false, 03:21:27 INFO - "project": "", 03:21:27 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:21:27 INFO - "changes": [ 03:21:27 INFO - { 03:21:27 INFO - "category": null, 03:21:27 INFO - "files": [ 03:21:27 INFO - { 03:21:27 INFO - "url": null, 03:21:27 INFO - "name": "https://queue.taskcluster.net/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 03:21:27 INFO - } 03:21:27 INFO - ], 03:21:27 INFO - "repository": "", 03:21:27 INFO - "rev": "866e6a5e2847194516ab65d71d19fd422842b22e", 03:21:27 INFO - "who": "sendchange", 03:21:27 INFO - "when": 1451301664, 03:21:27 INFO - "number": 7396554, 03:21:27 INFO - "comments": "", 03:21:27 INFO - "project": "", 03:21:27 INFO - "at": "Mon 28 Dec 2015 03:21:04", 03:21:27 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:21:27 INFO - "revlink": "", 03:21:27 INFO - "properties": [ 03:21:27 INFO - [ 03:21:27 INFO - "buildid", 03:21:27 INFO - "20151228004010", 03:21:27 INFO - "Change" 03:21:27 INFO - ], 03:21:27 INFO - [ 03:21:27 INFO - "builduid", 03:21:27 INFO - "8a22b45bf7d44c9193475f2120e91151", 03:21:27 INFO - "Change" 03:21:27 INFO - ], 03:21:27 INFO - [ 03:21:27 INFO - "nightly_build", 03:21:27 INFO - "True", 03:21:27 INFO - "Change" 03:21:27 INFO - ], 03:21:27 INFO - [ 03:21:27 INFO - "pgo_build", 03:21:27 INFO - "True", 03:21:27 INFO - "Change" 03:21:27 INFO - ] 03:21:27 INFO - ], 03:21:27 INFO - "revision": "866e6a5e2847194516ab65d71d19fd422842b22e" 03:21:27 INFO - } 03:21:27 INFO - ], 03:21:27 INFO - "revision": "866e6a5e2847194516ab65d71d19fd422842b22e" 03:21:27 INFO - } 03:21:27 INFO - } 03:21:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 03:21:27 INFO - Running post-action listener: _resource_record_post_action 03:21:27 INFO - ##### 03:21:27 INFO - ##### Running download-and-extract step. 03:21:27 INFO - ##### 03:21:27 INFO - Running pre-action listener: _resource_record_pre_action 03:21:27 INFO - Running main action method: download_and_extract 03:21:27 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:21:27 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')]} 03:21:27 INFO - https://queue.taskcluster.net/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:21:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/test_packages.json 03:21:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/test_packages.json 03:21:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:21:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:21:29 INFO - Downloaded 1302 bytes. 03:21:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:21:29 INFO - Using the following test package requirements: 03:21:29 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:21:29 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:29 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:21:29 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:29 INFO - u'jsshell-linux-x86_64.zip'], 03:21:29 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:29 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:21:29 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:21:29 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:29 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:21:29 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:29 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:21:29 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:29 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:21:29 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:21:29 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:21:29 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:21:29 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:21:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:29 INFO - https://queue.taskcluster.net/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:21:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:21:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:21:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/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 03:21:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/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 03:21:30 INFO - Downloaded 23023009 bytes. 03:21:30 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 03:21:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:21:30 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 03:21:31 INFO - Return code: 0 03:21:31 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 03:21: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')]} 03:21:31 INFO - https://queue.taskcluster.net/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:21:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:21:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:21:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/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 03:21:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/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 03:21:35 INFO - Downloaded 23023009 bytes. 03:21:35 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 03:21:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:21:35 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 03:21:37 INFO - Return code: 0 03:21:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:37 INFO - https://queue.taskcluster.net/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:21:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:21:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:21:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/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 03:21:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/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 03:21:38 INFO - Downloaded 11132038 bytes. 03:21:38 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 03:21:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:21:38 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 03:21:38 INFO - Return code: 0 03:21: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')]} 03:21:38 INFO - https://queue.taskcluster.net/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:21:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:21:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:21:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/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 03:21:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/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 03:21:40 INFO - Downloaded 58065395 bytes. 03:21:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:21:40 INFO - mkdir: /builds/slave/test-pgo/properties 03:21:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:21:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:21:40 INFO - Contents: 03:21:40 INFO - build_url:https://queue.taskcluster.net/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:21:40 INFO - Running post-action listener: _resource_record_post_action 03:21:40 INFO - Running post-action listener: set_extra_try_arguments 03:21:40 INFO - ##### 03:21:40 INFO - ##### Running populate-webroot step. 03:21:40 INFO - ##### 03:21:40 INFO - Running pre-action listener: _resource_record_pre_action 03:21:40 INFO - Running main action method: populate_webroot 03:21:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:21:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:21:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:21:40 INFO - '--tppagecycles', 03:21:40 INFO - '7'], 03:21:40 INFO - 'tests': ['tsvgm']}}, 03:21:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:21:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:21:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:21:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:21:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:21:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:21:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:40 INFO - 'talos_options': ['--e10s'], 03:21:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:21:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:40 INFO - 'tests': ['damp', 'tps']}, 03:21:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:40 INFO - 'talos_options': ['--e10s'], 03:21:40 INFO - 'tests': ['damp', 'tps']}, 03:21:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:21:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:21:40 INFO - 'other': {'tests': ['a11yr', 03:21:40 INFO - 'ts_paint', 03:21:40 INFO - 'tpaint', 03:21:40 INFO - 'sessionrestore', 03:21:40 INFO - 'sessionrestore_no_auto_restore']}, 03:21:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:21:40 INFO - 'tests': ['a11yr', 03:21:40 INFO - 'ts_paint', 03:21:40 INFO - 'tpaint', 03:21:40 INFO - 'sessionrestore', 03:21:40 INFO - 'sessionrestore_no_auto_restore']}, 03:21:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:21:40 INFO - 'tests': ['a11yr', 03:21:40 INFO - 'ts_paint', 03:21:40 INFO - 'tpaint', 03:21:40 INFO - 'sessionrestore', 03:21:40 INFO - 'sessionrestore_no_auto_restore']}, 03:21:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:21:40 INFO - 'tests': ['a11yr', 03:21:40 INFO - 'ts_paint', 03:21:40 INFO - 'tpaint', 03:21:40 INFO - 'sessionrestore', 03:21:40 INFO - 'sessionrestore_no_auto_restore']}, 03:21:40 INFO - 'other_l64': {'tests': ['a11yr', 03:21:40 INFO - 'ts_paint', 03:21:40 INFO - 'tpaint', 03:21:40 INFO - 'sessionrestore', 03:21:40 INFO - 'sessionrestore_no_auto_restore']}, 03:21:40 INFO - 'other_nol64': {'tests': ['a11yr', 03:21:40 INFO - 'ts_paint', 03:21:40 INFO - 'tpaint', 03:21:40 INFO - 'sessionrestore', 03:21:40 INFO - 'sessionrestore_no_auto_restore']}, 03:21:40 INFO - 'svgr': {'tests': ['tsvgx', 03:21:40 INFO - 'tsvgr_opacity', 03:21:40 INFO - 'tart', 03:21:40 INFO - 'tscrollx', 03:21:40 INFO - 'cart']}, 03:21:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:21:40 INFO - 'tests': ['tsvgx', 03:21:40 INFO - 'tsvgr_opacity', 03:21:40 INFO - 'tart', 03:21:40 INFO - 'tscrollx', 03:21:40 INFO - 'cart']}, 03:21:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:40 INFO - 'tests': ['tp5o']}, 03:21:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:40 INFO - 'talos_options': ['--e10s'], 03:21:40 INFO - 'tests': ['tp5o']}, 03:21:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:40 INFO - 'talos_options': ['--xperf_path', 03:21:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:40 INFO - 'tests': ['tp5n']}, 03:21:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:21:40 INFO - 'talos_options': ['--e10s', 03:21:40 INFO - '--xperf_path', 03:21:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:21:40 INFO - 'tests': ['tp5n']}}, 03:21:40 INFO - 'talos.zip': {'path': '', 03:21:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:21:40 INFO - Running post-action listener: _resource_record_post_action 03:21:40 INFO - ##### 03:21:40 INFO - ##### Running create-virtualenv step. 03:21:40 INFO - ##### 03:21:40 INFO - Running pre-action listener: _resource_record_pre_action 03:21:40 INFO - Running main action method: create_virtualenv 03:21:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:21:40 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 03:21:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:21:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:21:40 INFO - Using real prefix '/usr' 03:21:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:21:41 INFO - Installing distribute.............................................................................................................................................................................................done. 03:21:43 INFO - Installing pip.................done. 03:21:43 INFO - Return code: 0 03:21:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4eba095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2817a50>, '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 0x2783550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27839e0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', '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 03:21:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 03:21:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:21:43 INFO - Using env: {'DISPLAY': ':0', 03:21:43 INFO - 'HOME': '/home/cltbld', 03:21:43 INFO - 'LANG': 'en_US.UTF-8', 03:21:43 INFO - 'LANGUAGE': 'en_US:en', 03:21:43 INFO - 'LOGNAME': 'cltbld', 03:21:43 INFO - 'MAIL': '/var/mail/cltbld', 03:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:43 INFO - 'MOZ_NO_REMOTE': '1', 03:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:43 INFO - 'NO_EM_RESTART': '1', 03:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:21:43 INFO - 'PWD': '/builds/slave/test-pgo', 03:21:43 INFO - 'SHELL': '/bin/bash', 03:21:43 INFO - 'SHLVL': '1', 03:21:43 INFO - 'TERM': 'linux', 03:21:43 INFO - 'TMOUT': '86400', 03:21:43 INFO - 'USER': 'cltbld', 03:21:43 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', 03:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:43 INFO - '_': '/tools/buildbot/bin/python'} 03:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:43 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 03:21:43 INFO - Cleaning up... 03:21:43 INFO - Return code: 0 03:21:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:43 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4eba095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2817a50>, '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 0x2783550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27839e0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', '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 03:21:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:21:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:21:43 INFO - Using env: {'DISPLAY': ':0', 03:21:43 INFO - 'HOME': '/home/cltbld', 03:21:43 INFO - 'LANG': 'en_US.UTF-8', 03:21:43 INFO - 'LANGUAGE': 'en_US:en', 03:21:43 INFO - 'LOGNAME': 'cltbld', 03:21:43 INFO - 'MAIL': '/var/mail/cltbld', 03:21:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:43 INFO - 'MOZ_NO_REMOTE': '1', 03:21:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:43 INFO - 'NO_EM_RESTART': '1', 03:21:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:21:43 INFO - 'PWD': '/builds/slave/test-pgo', 03:21:43 INFO - 'SHELL': '/bin/bash', 03:21:43 INFO - 'SHLVL': '1', 03:21:43 INFO - 'TERM': 'linux', 03:21:43 INFO - 'TMOUT': '86400', 03:21:43 INFO - 'USER': 'cltbld', 03:21:43 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', 03:21:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:43 INFO - '_': '/tools/buildbot/bin/python'} 03:21:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:43 INFO - Downloading/unpacking psutil>=0.7.1 03:21:43 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 03:21:43 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 03:21:43 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 03:21:43 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 03:21:43 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 03:21:43 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 03:21:45 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:21:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:21:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:21:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:45 INFO - Installing collected packages: psutil 03:21:45 INFO - Running setup.py install for psutil 03:21:45 INFO - building 'psutil._psutil_linux' extension 03:21:45 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 03:21:45 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 03:21:45 INFO - building 'psutil._psutil_posix' extension 03:21:45 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 03:21:45 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 03:21:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:21:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:21:46 INFO - Successfully installed psutil 03:21:46 INFO - Cleaning up... 03:21:46 INFO - Return code: 0 03:21:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:21:46 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')]} 03:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:46 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')]} 03:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4eba095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2817a50>, '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 0x2783550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27839e0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', '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 03:21:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:21:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:21:46 INFO - Using env: {'DISPLAY': ':0', 03:21:46 INFO - 'HOME': '/home/cltbld', 03:21:46 INFO - 'LANG': 'en_US.UTF-8', 03:21:46 INFO - 'LANGUAGE': 'en_US:en', 03:21:46 INFO - 'LOGNAME': 'cltbld', 03:21:46 INFO - 'MAIL': '/var/mail/cltbld', 03:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:46 INFO - 'MOZ_NO_REMOTE': '1', 03:21:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:46 INFO - 'NO_EM_RESTART': '1', 03:21:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:21:46 INFO - 'PWD': '/builds/slave/test-pgo', 03:21:46 INFO - 'SHELL': '/bin/bash', 03:21:46 INFO - 'SHLVL': '1', 03:21:46 INFO - 'TERM': 'linux', 03:21:46 INFO - 'TMOUT': '86400', 03:21:46 INFO - 'USER': 'cltbld', 03:21:46 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', 03:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:46 INFO - '_': '/tools/buildbot/bin/python'} 03:21:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:21:47 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 03:21:47 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 03:21:47 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 03:21:47 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 03:21:47 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 03:21:47 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 03:21:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:21:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:21:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:21:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:21:48 INFO - Installing collected packages: mozsystemmonitor 03:21:48 INFO - Running setup.py install for mozsystemmonitor 03:21:49 INFO - Successfully installed mozsystemmonitor 03:21:49 INFO - Cleaning up... 03:21:49 INFO - Return code: 0 03:21:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4eba095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2817a50>, '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 0x2783550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27839e0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', '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 03:21:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:21:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:21:49 INFO - Using env: {'DISPLAY': ':0', 03:21:49 INFO - 'HOME': '/home/cltbld', 03:21:49 INFO - 'LANG': 'en_US.UTF-8', 03:21:49 INFO - 'LANGUAGE': 'en_US:en', 03:21:49 INFO - 'LOGNAME': 'cltbld', 03:21:49 INFO - 'MAIL': '/var/mail/cltbld', 03:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:49 INFO - 'MOZ_NO_REMOTE': '1', 03:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:49 INFO - 'NO_EM_RESTART': '1', 03:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:21:49 INFO - 'PWD': '/builds/slave/test-pgo', 03:21:49 INFO - 'SHELL': '/bin/bash', 03:21:49 INFO - 'SHLVL': '1', 03:21:49 INFO - 'TERM': 'linux', 03:21:49 INFO - 'TMOUT': '86400', 03:21:49 INFO - 'USER': 'cltbld', 03:21:49 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', 03:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:49 INFO - '_': '/tools/buildbot/bin/python'} 03:21:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:49 INFO - Downloading/unpacking blobuploader==1.2.4 03:21:49 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 03:21:49 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 03:21:49 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 03:21:49 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 03:21:49 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 03:21:49 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 03:21:50 INFO - Downloading blobuploader-1.2.4.tar.gz 03:21:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:21:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:21:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:21:51 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 03:21:51 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 03:21:51 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 03:21:51 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 03:21:51 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 03:21:51 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 03:21:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:21:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:21:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:21:51 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 03:21:51 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 03:21:51 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 03:21:51 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 03:21:51 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 03:21:51 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 03:21:51 INFO - Downloading docopt-0.6.1.tar.gz 03:21:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:21:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:21:51 INFO - Installing collected packages: blobuploader, requests, docopt 03:21:51 INFO - Running setup.py install for blobuploader 03:21:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:21:51 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:21:51 INFO - Running setup.py install for requests 03:21:52 INFO - Running setup.py install for docopt 03:21:52 INFO - Successfully installed blobuploader requests docopt 03:21:52 INFO - Cleaning up... 03:21:52 INFO - Return code: 0 03:21:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4eba095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2817a50>, '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 0x2783550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27839e0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', '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 03:21:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:21:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:21:52 INFO - Using env: {'DISPLAY': ':0', 03:21:52 INFO - 'HOME': '/home/cltbld', 03:21:52 INFO - 'LANG': 'en_US.UTF-8', 03:21:52 INFO - 'LANGUAGE': 'en_US:en', 03:21:52 INFO - 'LOGNAME': 'cltbld', 03:21:52 INFO - 'MAIL': '/var/mail/cltbld', 03:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:52 INFO - 'MOZ_NO_REMOTE': '1', 03:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:52 INFO - 'NO_EM_RESTART': '1', 03:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:21:52 INFO - 'PWD': '/builds/slave/test-pgo', 03:21:52 INFO - 'SHELL': '/bin/bash', 03:21:52 INFO - 'SHLVL': '1', 03:21:52 INFO - 'TERM': 'linux', 03:21:52 INFO - 'TMOUT': '86400', 03:21:52 INFO - 'USER': 'cltbld', 03:21:52 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', 03:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:52 INFO - '_': '/tools/buildbot/bin/python'} 03:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:21:52 INFO - Running setup.py (path:/tmp/pip-OeS8NJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:21:52 INFO - Running setup.py (path:/tmp/pip-kWsh3L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:21:52 INFO - Running setup.py (path:/tmp/pip-amSN6g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:21:52 INFO - Running setup.py (path:/tmp/pip-XZIH66-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:21:52 INFO - Running setup.py (path:/tmp/pip-JxMSUp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:21:52 INFO - Running setup.py (path:/tmp/pip-0jgGrR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:21:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:21:52 INFO - Running setup.py (path:/tmp/pip-FBUEP2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:21:53 INFO - Running setup.py (path:/tmp/pip-s1KUHq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:21:53 INFO - Running setup.py (path:/tmp/pip-xlwFMc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:21:53 INFO - Running setup.py (path:/tmp/pip-QTdA4H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:21:53 INFO - Running setup.py (path:/tmp/pip-5bP0f2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:21:53 INFO - Running setup.py (path:/tmp/pip-A3y487-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:21:53 INFO - Running setup.py (path:/tmp/pip-GElFR2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:21:53 INFO - Running setup.py (path:/tmp/pip-RJ3nkS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:21:53 INFO - Running setup.py (path:/tmp/pip-lHuziC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:21:53 INFO - Running setup.py (path:/tmp/pip-LirCyx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:21:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:21:53 INFO - Running setup.py (path:/tmp/pip-jf3tYK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:21:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:21:53 INFO - Running setup.py install for manifestparser 03:21:53 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:21:53 INFO - Running setup.py install for mozcrash 03:21:53 INFO - Running setup.py install for mozdebug 03:21:54 INFO - Running setup.py install for mozdevice 03:21:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:21:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:21:54 INFO - Running setup.py install for mozfile 03:21:54 INFO - Running setup.py install for mozhttpd 03:21:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:21:54 INFO - Running setup.py install for mozinfo 03:21:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:21:54 INFO - Running setup.py install for mozInstall 03:21:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:21:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:21:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:21:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:21:54 INFO - Running setup.py install for mozleak 03:21:54 INFO - Running setup.py install for mozlog 03:21:54 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:21:54 INFO - Running setup.py install for moznetwork 03:21:54 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:21:54 INFO - Running setup.py install for mozprocess 03:21:54 INFO - Running setup.py install for mozprofile 03:21:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:21:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:21:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:21:55 INFO - Running setup.py install for mozrunner 03:21:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:21:55 INFO - Running setup.py install for mozscreenshot 03:21:55 INFO - Running setup.py install for moztest 03:21:55 INFO - Running setup.py install for mozversion 03:21:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:21:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:21:55 INFO - Cleaning up... 03:21:55 INFO - Return code: 0 03:21:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:21:55 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')]} 03:21:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:55 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')]} 03:21:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4eba095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2817a50>, '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 0x2783550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27839e0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', '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 03:21:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:21:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:21:55 INFO - Using env: {'DISPLAY': ':0', 03:21:55 INFO - 'HOME': '/home/cltbld', 03:21:55 INFO - 'LANG': 'en_US.UTF-8', 03:21:55 INFO - 'LANGUAGE': 'en_US:en', 03:21:55 INFO - 'LOGNAME': 'cltbld', 03:21:55 INFO - 'MAIL': '/var/mail/cltbld', 03:21:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:55 INFO - 'MOZ_NO_REMOTE': '1', 03:21:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:55 INFO - 'NO_EM_RESTART': '1', 03:21:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:21:55 INFO - 'PWD': '/builds/slave/test-pgo', 03:21:55 INFO - 'SHELL': '/bin/bash', 03:21:55 INFO - 'SHLVL': '1', 03:21:55 INFO - 'TERM': 'linux', 03:21:55 INFO - 'TMOUT': '86400', 03:21:55 INFO - 'USER': 'cltbld', 03:21:55 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', 03:21:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:55 INFO - '_': '/tools/buildbot/bin/python'} 03:21:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:21:55 INFO - Running setup.py (path:/tmp/pip-p2dRe2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:21:55 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)) 03:21:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:21:55 INFO - Running setup.py (path:/tmp/pip-HID_u0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:21:55 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)) 03:21:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:21:55 INFO - Running setup.py (path:/tmp/pip-sEEm7J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:21:55 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)) 03:21:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:21:55 INFO - Running setup.py (path:/tmp/pip-Kifxxu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:21:56 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)) 03:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:21:56 INFO - Running setup.py (path:/tmp/pip-Wgef5a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:21:56 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)) 03:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:21:56 INFO - Running setup.py (path:/tmp/pip-80qQVe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:21:56 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)) 03:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:21:56 INFO - Running setup.py (path:/tmp/pip-poM4xS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:21:56 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)) 03:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:21:56 INFO - Running setup.py (path:/tmp/pip-QqbJNy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:21:56 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)) 03:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:21:56 INFO - Running setup.py (path:/tmp/pip-D5AQ5o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:21:56 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)) 03:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:21:56 INFO - Running setup.py (path:/tmp/pip-LBOHOQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:21:56 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)) 03:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:21:56 INFO - Running setup.py (path:/tmp/pip-8dPzOw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:21:56 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)) 03:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:21:56 INFO - Running setup.py (path:/tmp/pip-C3LCbm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:21:56 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)) 03:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:21:56 INFO - Running setup.py (path:/tmp/pip-11rqDw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:21:56 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)) 03:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:21:56 INFO - Running setup.py (path:/tmp/pip-0OKzJH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:21:56 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)) 03:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:21:56 INFO - Running setup.py (path:/tmp/pip-sT2Utg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:21:56 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)) 03:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:21:56 INFO - Running setup.py (path:/tmp/pip-mcF84R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:21:56 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)) 03:21:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:21:56 INFO - Running setup.py (path:/tmp/pip-selChc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:21:56 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)) 03:21:56 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)) 03:21:56 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)) 03:21:56 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)) 03:21:56 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)) 03:21:56 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)) 03:21:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:58 INFO - Downloading blessings-1.5.1.tar.gz 03:21:58 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:21:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:21:58 INFO - Installing collected packages: blessings 03:21:58 INFO - Running setup.py install for blessings 03:21:58 INFO - Successfully installed blessings 03:21:58 INFO - Cleaning up... 03:21:58 INFO - Return code: 0 03:21:58 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:21:58 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:21:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:21:59 INFO - Reading from file tmpfile_stdout 03:21:59 INFO - Current package versions: 03:21:59 INFO - argparse == 1.2.1 03:21:59 INFO - blessings == 1.5.1 03:21:59 INFO - blobuploader == 1.2.4 03:21:59 INFO - docopt == 0.6.1 03:21:59 INFO - manifestparser == 1.1 03:21:59 INFO - mozInstall == 1.12 03:21:59 INFO - mozcrash == 0.16 03:21:59 INFO - mozdebug == 0.1 03:21:59 INFO - mozdevice == 0.47 03:21:59 INFO - mozfile == 1.2 03:21:59 INFO - mozhttpd == 0.7 03:21:59 INFO - mozinfo == 0.9 03:21:59 INFO - mozleak == 0.1 03:21:59 INFO - mozlog == 3.1 03:21:59 INFO - moznetwork == 0.27 03:21:59 INFO - mozprocess == 0.22 03:21:59 INFO - mozprofile == 0.27 03:21:59 INFO - mozrunner == 6.11 03:21:59 INFO - mozscreenshot == 0.1 03:21:59 INFO - mozsystemmonitor == 0.0 03:21:59 INFO - moztest == 0.7 03:21:59 INFO - mozversion == 1.4 03:21:59 INFO - psutil == 3.1.1 03:21:59 INFO - requests == 1.2.3 03:21:59 INFO - wsgiref == 0.1.2 03:21:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f4eba095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2817a50>, '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 0x2783550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27839e0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', '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 03:21:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 03:21:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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 03:21:59 INFO - Using env: {'DISPLAY': ':0', 03:21:59 INFO - 'HOME': '/home/cltbld', 03:21:59 INFO - 'LANG': 'en_US.UTF-8', 03:21:59 INFO - 'LANGUAGE': 'en_US:en', 03:21:59 INFO - 'LOGNAME': 'cltbld', 03:21:59 INFO - 'MAIL': '/var/mail/cltbld', 03:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:59 INFO - 'MOZ_NO_REMOTE': '1', 03:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:59 INFO - 'NO_EM_RESTART': '1', 03:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:21:59 INFO - 'PWD': '/builds/slave/test-pgo', 03:21:59 INFO - 'SHELL': '/bin/bash', 03:21:59 INFO - 'SHLVL': '1', 03:21:59 INFO - 'TERM': 'linux', 03:21:59 INFO - 'TMOUT': '86400', 03:21:59 INFO - 'USER': 'cltbld', 03:21:59 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', 03:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:59 INFO - '_': '/tools/buildbot/bin/python'} 03:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:59 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)) 03:21:59 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)) 03:21:59 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)) 03:21:59 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)) 03:21:59 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)) 03:21:59 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)) 03:21:59 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)) 03:21:59 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)) 03:21:59 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)) 03:21:59 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)) 03:21:59 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)) 03:21:59 INFO - Cleaning up... 03:21:59 INFO - Return code: 0 03:21:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:21:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4eba095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2817a50>, '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 0x2783550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27839e0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', '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 03:21:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 03:21:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:21:59 INFO - Using env: {'DISPLAY': ':0', 03:21:59 INFO - 'HOME': '/home/cltbld', 03:21:59 INFO - 'LANG': 'en_US.UTF-8', 03:21:59 INFO - 'LANGUAGE': 'en_US:en', 03:21:59 INFO - 'LOGNAME': 'cltbld', 03:21:59 INFO - 'MAIL': '/var/mail/cltbld', 03:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:21:59 INFO - 'MOZ_NO_REMOTE': '1', 03:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:21:59 INFO - 'NO_EM_RESTART': '1', 03:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:21:59 INFO - 'PWD': '/builds/slave/test-pgo', 03:21:59 INFO - 'SHELL': '/bin/bash', 03:21:59 INFO - 'SHLVL': '1', 03:21:59 INFO - 'TERM': 'linux', 03:21:59 INFO - 'TMOUT': '86400', 03:21:59 INFO - 'USER': 'cltbld', 03:21:59 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', 03:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:21:59 INFO - '_': '/tools/buildbot/bin/python'} 03:21:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:21:59 INFO - Downloading/unpacking jsonschema 03:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:21:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:22:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 03:22:01 INFO - Downloading/unpacking functools32 (from jsonschema) 03:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:01 INFO - Downloading functools32-3.2.3-2.tar.gz 03:22:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:22:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:22:01 INFO - warning: no files found matching '*.txt' 03:22:01 INFO - no previously-included directories found matching 'build' 03:22:01 INFO - no previously-included directories found matching 'dist' 03:22:01 INFO - no previously-included directories found matching '.git*' 03:22:01 INFO - Installing collected packages: jsonschema, functools32 03:22:01 INFO - Running setup.py install for functools32 03:22:01 INFO - warning: no files found matching '*.txt' 03:22:01 INFO - no previously-included directories found matching 'build' 03:22:01 INFO - no previously-included directories found matching 'dist' 03:22:01 INFO - no previously-included directories found matching '.git*' 03:22:01 INFO - Successfully installed jsonschema functools32 03:22:01 INFO - Cleaning up... 03:22:01 INFO - Return code: 0 03:22:01 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:22:01 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')]} 03:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:01 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')]} 03:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4eba095f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26b78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2785450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2817a50>, '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 0x2783550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27839e0>, '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': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', '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 03:22:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 03:22:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:22:01 INFO - Using env: {'DISPLAY': ':0', 03:22:01 INFO - 'HOME': '/home/cltbld', 03:22:01 INFO - 'LANG': 'en_US.UTF-8', 03:22:01 INFO - 'LANGUAGE': 'en_US:en', 03:22:01 INFO - 'LOGNAME': 'cltbld', 03:22:01 INFO - 'MAIL': '/var/mail/cltbld', 03:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:01 INFO - 'MOZ_NO_REMOTE': '1', 03:22:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:01 INFO - 'NO_EM_RESTART': '1', 03:22:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:22:01 INFO - 'PWD': '/builds/slave/test-pgo', 03:22:01 INFO - 'SHELL': '/bin/bash', 03:22:01 INFO - 'SHLVL': '1', 03:22:01 INFO - 'TERM': 'linux', 03:22:01 INFO - 'TMOUT': '86400', 03:22:01 INFO - 'USER': 'cltbld', 03:22:01 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', 03:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:01 INFO - '_': '/tools/buildbot/bin/python'} 03:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:01 INFO - Downloading/unpacking flake8 03:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:03 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:22:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 03:22:03 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:22:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 03:22:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 03:22:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:22:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:22:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:22:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:22:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:22:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:22:04 INFO - no previously-included directories found matching 'docs/_build' 03:22:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:22:04 INFO - Running setup.py install for pep8 03:22:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:22:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:22:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:22:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:22:04 INFO - no previously-included directories found matching 'docs/_build' 03:22:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:22:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:22:04 INFO - Cleaning up... 03:22:04 INFO - Return code: 0 03:22:04 INFO - Running post-action listener: _resource_record_post_action 03:22:04 INFO - Running post-action listener: _start_resource_monitoring 03:22:04 INFO - Starting resource monitoring. 03:22:04 INFO - ##### 03:22:04 INFO - ##### Running install step. 03:22:04 INFO - ##### 03:22:04 INFO - Running pre-action listener: _resource_record_pre_action 03:22:04 INFO - Running main action method: install 03:22:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:22:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:22:04 INFO - Reading from file tmpfile_stdout 03:22:04 INFO - Detecting whether we're running mozinstall >=1.0... 03:22:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:22:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:22:04 INFO - Reading from file tmpfile_stdout 03:22:04 INFO - Output received: 03:22:04 INFO - Usage: mozinstall [options] installer 03:22:04 INFO - Options: 03:22:04 INFO - -h, --help show this help message and exit 03:22:04 INFO - -d DEST, --destination=DEST 03:22:04 INFO - Directory to install application into. [default: 03:22:04 INFO - "/builds/slave/test-pgo"] 03:22:04 INFO - --app=APP Application being installed. [default: firefox] 03:22:04 INFO - mkdir: /builds/slave/test-pgo/build/application 03:22:04 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'] 03:22:04 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 03:22:19 INFO - Reading from file tmpfile_stdout 03:22:19 INFO - Output received: 03:22:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:22:19 INFO - Running post-action listener: _resource_record_post_action 03:22:19 INFO - ##### 03:22:19 INFO - ##### Running run-tests step. 03:22:19 INFO - ##### 03:22:19 INFO - Running pre-action listener: _resource_record_pre_action 03:22:19 INFO - Running main action method: run_tests 03:22:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:22:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:22:19 INFO - Python 2.7.3 03:22:19 INFO - Return code: 0 03:22:19 INFO - grabbing minidump binary from tooltool 03: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')]} 03:22:19 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 0x2817a50>, '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 0x2783550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27839e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:22:19 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 03:22:19 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 03:22:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:22:19 INFO - Return code: 0 03:22:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:22:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:22:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:22:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:22:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:22:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:22:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:22:20 INFO - Return code: 0 03:22:20 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/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:22:20 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/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost 03:22:20 INFO - Using env: {'DISPLAY': ':0', 03:22:20 INFO - 'HOME': '/home/cltbld', 03:22:20 INFO - 'LANG': 'en_US.UTF-8', 03:22:20 INFO - 'LANGUAGE': 'en_US:en', 03:22:20 INFO - 'LOGNAME': 'cltbld', 03:22:20 INFO - 'MAIL': '/var/mail/cltbld', 03:22:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:22:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:22:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:20 INFO - 'MOZ_NO_REMOTE': '1', 03:22:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:22:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:20 INFO - 'NO_EM_RESTART': '1', 03:22:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:22:20 INFO - 'PWD': '/builds/slave/test-pgo', 03:22:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:22:20 INFO - 'SHELL': '/bin/bash', 03:22:20 INFO - 'SHLVL': '1', 03:22:20 INFO - 'TERM': 'linux', 03:22:20 INFO - 'TMOUT': '86400', 03:22:20 INFO - 'USER': 'cltbld', 03:22:20 INFO - 'XDG_SESSION_COOKIE': '5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237', 03:22:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:20 INFO - '_': '/tools/buildbot/bin/python'} 03:22:20 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/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost'] with output_timeout 3600 03:22:20 INFO - mozversion INFO | application_buildid: 20151228004010 03:22:20 INFO - mozversion INFO | application_changeset: 866e6a5e2847194516ab65d71d19fd422842b22e 03:22:20 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:22:20 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:22:20 INFO - mozversion INFO | application_name: Firefox 03:22:20 INFO - mozversion INFO | application_remotingname: firefox-dev 03:22:20 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:22:20 INFO - mozversion INFO | application_vendor: Mozilla 03:22:20 INFO - mozversion INFO | application_version: 45.0a2 03:22:20 INFO - mozversion INFO | platform_buildid: 20151228004010 03:22:20 INFO - mozversion INFO | platform_changeset: 866e6a5e2847194516ab65d71d19fd422842b22e 03:22:20 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:22:20 INFO - mozversion INFO | platform_version: 45.0a2 03:22:20 INFO - 2015-12-28 03:22:20,596 DEBUG : using testdate: 1451301740 03:22:20 INFO - 2015-12-28 03:22:20,596 DEBUG : actual date: 1451301740 03:22:20 INFO - 2015-12-28 03:22:20,611 INFO : starting webserver on 'localhost:43678' 03:22:20 INFO - 2015-12-28 03:22:20,612 INFO : Starting test suite talos-linux64-ix-024.e 03:22:20 INFO - 2015-12-28 03:22:20,612 INFO : Starting test dromaeo_css 03:22:20 INFO - 2015-12-28 03:22:20,612 DEBUG : operating with platform_type : linux_ 03:22:20 INFO - 2015-12-28 03:22:20,613 INFO : Initialising browser for dromaeo_css test... 03:22:20 INFO - 2015-12-28 03:22:20,629 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpddNYfa/profile http://localhost:43678/getInfo.html 03:22:25 INFO - 2015-12-28 03:22:25,148 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:22:25 INFO - 2015-12-28 03:22:25,149 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:22:25 INFO - 2015-12-28 03:22:25,149 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 03:22:25 INFO - 2015-12-28 03:22:25,149 DEBUG : BROWSER_OUTPUT: __metrics 03:22:26 INFO - 2015-12-28 03:22:26,069 INFO : Browser initialized. 03:22:26 INFO - 2015-12-28 03:22:26,069 INFO : Running cycle 1/1 for dromaeo_css test... 03:22:26 INFO - 2015-12-28 03:22:26,069 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpddNYfa/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:22:37 INFO - 2015-12-28 03:22:37,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 138383360 03:22:37 INFO - 2015-12-28 03:22:37,868 DEBUG : BROWSER_OUTPUT: 03:23:27 INFO - 2015-12-28 03:23:27,492 DEBUG : BROWSER_OUTPUT: 1451301807488 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] 03:25:35 INFO - 2015-12-28 03:25:35,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43678/tests/dromaeo/cssquery-ext.html) 03:25:36 INFO - 2015-12-28 03:25:36,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 142303232 03:25:36 INFO - 2015-12-28 03:25:36,485 DEBUG : BROWSER_OUTPUT: 03:28:38 INFO - 2015-12-28 03:28:38,296 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/dromaeo/cssquery-ext.html (next: http://localhost:43678/tests/dromaeo/cssquery-jquery.html) 03:28:38 INFO - 2015-12-28 03:28:38,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 139513856 03:28:38 INFO - 2015-12-28 03:28:38,884 DEBUG : BROWSER_OUTPUT: 03:31:40 INFO - 2015-12-28 03:31:40,482 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43678/tests/dromaeo/cssquery-mootools.html) 03:31:41 INFO - 2015-12-28 03:31:41,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 138899456 03:31:41 INFO - 2015-12-28 03:31:41,063 DEBUG : BROWSER_OUTPUT: 03:34:42 INFO - 2015-12-28 03:34:42,616 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43678/tests/dromaeo/cssquery-prototype.html) 03:34:43 INFO - 2015-12-28 03:34:43,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 139939840 03:34:43 INFO - 2015-12-28 03:34:43,210 DEBUG : BROWSER_OUTPUT: 03:37:45 INFO - 2015-12-28 03:37:45,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43678/tests/dromaeo/cssquery-yui.html) 03:37:46 INFO - 2015-12-28 03:37:46,105 DEBUG : BROWSER_OUTPUT: RSS: Main: 140816384 03:37:46 INFO - 2015-12-28 03:37:46,106 DEBUG : BROWSER_OUTPUT: 03:40:48 INFO - 2015-12-28 03:40:48,109 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/dromaeo/cssquery-yui.html (next: http://localhost:43678/tests/dromaeo/cssquery-dojo.html) 03:40:48 INFO - 2015-12-28 03:40:48,360 DEBUG : BROWSER_OUTPUT: RSS: Main: 142487552 03:40:48 INFO - 2015-12-28 03:40:48,360 DEBUG : BROWSER_OUTPUT: 03:40:48 INFO - 2015-12-28 03:40:48,360 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:40:48 INFO - 2015-12-28 03:40:48,360 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:40:48 INFO - 2015-12-28 03:40:48,361 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:40:48 INFO - 2015-12-28 03:40:48,361 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:40:48 INFO - 2015-12-28 03:40:48,362 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3325.1520862180146;3376.5441665375165;3388.542546756187;3399.4900764885265;3406.437937740273;5588.357338906027;5631.465010823976;5647.068233741433;5647.3505546862125;5653.802116925908;5584.86037849054;5614.27014488117;5621.578381621374;5624.325080990287;5666.546676265899;5108.259302401149;5165.81919632813;5202.635815492917;5242.55438287746;5251.870847767729;5014.097462456756;5111.897762044757;5113.360829896263;5134.229865520183;5256.474352564732;5132.307138536287;5141.922871156936;5205.141151709963;5215.556677682402;5239.3712754469325;5196.506331898482;5229.947700523003;5241.606879484054;5261.76322065508;5304.283921670563;4929.556339929388;5073.847784566469;5172.19830926207;5180.766865491062;5242.973785131088;5372.489613486712;5425.457454254582;5434;5459.617826752129;5496.395396506381;5936.7031648417405;5938.10928360745;5963.165156878041;5964.97017514914;5973.761049558012;5922.526197904201;5942.821715348547;5995.160677505153;6007.339192688801;6029.60807547508;5666.801661941812;5671.092625179951;5676.233708449347;5688.800891968803;5751.05107657236;6170;6170.642458659087;6174.969125154345;6184.567080304426;6189.442950134509;5725.141228815628;5725.885482290331;5862.12068189775;5989.371116032754;6036.63780173191;6024.939750602525;6026.487748541423;6045.879082418327;6048.9697551512845;6073.848153796191;5965.164876917235;5999.640021598718;6025.6685882276015;6029.125776762433;6040.577159598786;5979;6006.519478441714;6060;6118.223266370627;6121.54443000217;4671.8364857229835;4672.43930728308;4679.22792739201;4679.64902632304;4701.858944231679;4042.6765858731233;4170.937435938464;4177.10192308649;4183.3515805050265;4202.075543380452;5602.411746766612;5652.7738890443925;5690.97562438765;5739.196512488255;5768.913466298009;6114.296855861544;6118;6166.907496387557;6180.072989051589;6185.8144255672405;5608.242887210175;5798.768049278066;5843.211166492554;5857.6192547485125;5863.941360586339;5139.280500729901;5163.7676304566385;5192.143296356135;5263.34208223972;5304.177852432879;6157.907631385533;6236.345183755731;6240.032794916795;6241.719122639402;6275;5947.434993675767;6138.631682099178;6139.570230083851;6141.8464538385115;6149.723262453111;6058.7273572688455;6069.787557435468;6080;6123.050927106306;6183.721732522137;5974.193483879794;6098.512119030555;6109.633421994695;6120.173776540289;6138.631682099089;5948.375420580776;6051.455369016633;6149.947034422519;6190.133381326528;6215.285242197205;5788.218590490398;5794.62334948227;5798.333191682842;5851.239338886088;5887.411258874078;5958.791442299672;5982.0727787193055;5990.221271234712;5994.220751302303;5996.8800623988145;5667.20659107717;5744.885102298014;5847.883042339215;5862.355140934579;5917.201177841109;5924.4667979882015;6009.699515024318;6034.24571928509;6071.635701857903;6072.210612620331;5897.262842144732;5901.793437229848;5915.467607915309;5930.525557955267;5936.851578710567 03:40:48 INFO - 2015-12-28 03:40:48,362 DEBUG : BROWSER_OUTPUT: |1;ext.html;579.7854793726322;630.9211248764612;632.7310892870529;637.1589501857547;641.249737806766;31482.370352592934;39345.60654393459;39649.40525892114;39859;40112.398314025275;44973.550264497346;45274;45284;45510.31734523985;45654.54345456544;9094.408863423872;9262.583183756748;9269.073092690744;9269.721908342726;9294.767630809216;8942.687005954793;9083.636654533844;9105.726828195166;9128.041555636662;9131.26949844011;9050.909490905073;9098.818023639524;9144;9150.954245228764;9170;9096.363254572183;9136.45181289118;9158.496282704482;9164.908350916505;9169.40398874071;8987.730368088902;9090.63637454501;9107.63569457221;9107.863382049274;9125.996140424548;42115;42350.36474452886;42384.36423453651;42543.149137017084;42728;3687.3178461984617;4037;4080.6735461163335;4115.54728979812;4181.310083836163;31169.532457013163;31373.84313078443;31604;31615.20961975946;31774.523382149287;4201.642860356873;4254.638355739766;4256.382824490432;4347.630451411602;4407.955920440787;267637;267763;420395;428090;451385;60104.69947650234;60391;60507;60836.39163608396;60866;61956;62610.0608490873;62714.372856271766;62717.68641156856;62761.68619156875;18008.189631466616;18184.818151818312;18285.360012399502;18386.81613183878;18394.724079138825;13734.107283026571;13848.09987350819;13882.305884705724;13890.4443822248;13937.512187073404;20857.1657133716;21212.893935530225;21360.35918922435;21365.25221617236;21389.572208555743;7770.261825126604;7853.725119620786;7907.369388540086;8026.398020148512;8074.959625201954;1059.5708737961138;1090.8854570270007;1114.1866437500507;1131.643532287327;1212.3812564859861;29364.559531607043;29501.557476637867;30063.398732025675;30264.84867575648;30584.38831223363;1123.842662027317;1124.4771181400688;1144.2047776795048;1149.5689116581282;1245.3897590180927;15792.131432771308;16209.756853647204;16446.75329870053;17114.572135696708;17125.22936467862;346273;355856;356242;356965;357374;47297.763511182224;47399.52600473951;47551.52448475471;47639.5236047642;47798.283025754645;1424.8717615414662;1433.089987857697;1433.2976841347872;1453.549399686122;1458.9197594132213;28015.719842802126;28430.71569284281;28438.43123137567;29024.129276121752;29697.554536681535;44987.10025799531;45337;45369.319460207465;45386.319205211286;45492.09015819599;259447;260627;262470;262651;263156;32838;32957.50563741498;33107;34128;34708;39003.41494877522;39013;39083.609163908;39764.40353394643;40038.39942400808;37336;37656;37711.62288377191;37737.81131094327;38611.227775444895;36711.43752369984;37170.62829371672;37201;37231.6276837239;37473.250534988605;34131.65868341285;34457.138571535914;34762.304753905286;34973.300533989684;34983;30181.849090754407;30283.394332113676;30334.241643959078;30374.84812575923;30487.085387438412;23959.640605390585;24335;25318;26202.60696089522;26208 03:40:48 INFO - 2015-12-28 03:40:48,364 DEBUG : BROWSER_OUTPUT: |2;jquery.html;368.85798967397545;382.25269597936057;390.3188935307887;391.8550136449513;394.3965732429384;16123.113228772441;17520.737188942177;17621.911890440562;19133.808661913376;19324.710129348052;11351.772964540703;11438.313701177934;11464.71338216543;17205.569860753487;17767.378141765043;4954.801807927679;4966.255061740731;5049.9747501262445;5075.467075957026;5076.543111119999;5039.974800125994;5246.554042906358;5327.680339179642;5337.412884582693;5381.5425688816495;5292.682439053649;5318.787248510055;5345.679259244438;5350.464953504657;5464.0711079116645;5433.918491222596;5482.068048431756;5484.122540393538;5495.258140151069;5509.614326997112;5290.0477913975465;5292.364916210041;5315.495027972375;5320.920186197211;5579.7489112990015;12802.423890924838;13148.474061037547;13168.6707832304;15165.848341516554;21616.135354585796;2237.0827960536103;2299.5630830142386;2319.362175401778;2398.604230301998;2436.537057958982;9870.654527091589;9898.653547125889;10040.94979525105;10189.59241630334;10208.438535880523;1961.63709713702;1966.0071663809827;1969.7340858983996;1982.7818939916742;2073.3676228750223;65916.3408365915;68208.3179168212;68327;68387.65806170937;68639;10578.206634502443;10821.458927053773;10821.783564328827;10869.402182880018;10874.782504349869;14218.644533886736;14357.712845743026;14369.928150359181;14384.712305753827;14410.639734006523;8193.590320483952;8266.751997440086;8308.086110527836;8365.1216622255;8423.073461919184;8233.3824963128;8233.50598964064;8244.422890397615;8284.958575207205;8327.958360208282;4578.702384345007;4624.953750462452;4628.213203755369;4630.21286381316;8313.750587482386;3404;3444.3800115979366;3457.9654203457644;3461.9653803462147;3609.4585812127866;1045.9529321180564;1111.1222134513805;1114;1121.3720316622716;1144.1476100305326;15487;18078.09609519519;18263.63472730538;18358.449246522625;18419.079046047646;977.1449981266392;1011.4993078426226;1012.2256473797551;1013.6654903881702;1014.898510148994;9592;10091.091801737879;10109.64616238428;10248.97510248984;10263.7434064149;645306;650908;652832;663888;688172;78495;86516.56741716251;87010.56494717613;87291.56354218189;88065.55967220123;1202.5851081376911;1216.403962058585;1230.4585982167816;1234.456838990859;1236.6970092327258;15569.76645350298;15893.443729469413;16368.918155409146;16904.154792260582;16986.490405287863;34722.13194670052;35516.644833551334;35769.28461430705;36203.09492262715;39689;45174.09651807011;46638.30042549297;46916;47749.283760742925;49086;10060.49697515136;10166.88164301941;10199.694009179737;10431.852496225258;10479.580816767244;17611.559711006816;18090.63818723592;18333.724994124834;18503.722444163617;18509.167087480826;12388.442520086797;16145.75781363304;16450.83549164541;16463.34146634121;16475.093869836794;13036.087473876738;13240.668983275495;14507;15122.54632361031;15788.921055394649;16225.918870405572;16366.509004729876;16786;16826;16912.408065717642;10074.345167564084;10121.139703125316;10528.420936848546;10548.103411209826;10548.156147508334;10739.409332486475;10828.242023058625;12568.245905245714;16333.428330008393;16466.67066658684 03:40:48 INFO - 2015-12-28 03:40:48,365 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1550.620098075971;1613.9838601613994;1623.2127418202174;1834.4404956488274;1904.1145867171772;7669.463137580372;7830.334421574159;7992.560409177493;8071.273585377322;8083.555404452753;8021.719239826607;8075.192480751936;8121.51270923745;8137.552434616094;8194.754157375273;2336.0655737704883;2374.833761636686;2376.0495801679294;2377.821663375245;2378.5599664062206;2413.625887987356;2421.322029831641;2479.5536803375385;2482.0816297969777;2482.118847809029;2352.3766201956496;2355.3287313115766;2374.8218883583713;2387.8328517003815;2418.2140804238607;2356.5286942611547;2399.9280021599293;2402.0752010476003;2435.902563897442;2440.1093600835743;2389.689340385756;2428.477877256398;2428.9757102428925;2429.356220601542;2435.111184417675;7805.687772489094;7919.128895821455;7938.960305198437;7958.6418611162635;7963.3231175350165;4877.3903262092235;4918.458969513351;4923.58149557288;4956.826511072095;4958.454569997298;3170.936581268385;3209.711125998648;3248.13924310058;3248.6101667800017;3248.658890816454;958.242988039448;972.0862389353985;990.7374545745383;1030.0832259289239;1058.751193469534;10676.466176691212;10708.41103739294;10732.517036733288;10757.085647719954;10766.946165269124;4256;4314.395984562164;4326.372675961968;4334.111507141029;4341.739495630272;8805.075467075865;8814.206721395105;8825.205731484197;8828.38201325901;8837.513936733412;4886.780094895738;4905.632077594195;4911.631627627942;4914.483979182134;4915.778789954461;4458.08609235106;4497.797599108048;4498.910021799611;4500.234960056799;4501;3519.348920449725;3541.29174165168;3564.928701426009;3573.213892943548;3573.5354403927845;1073.581303291717;1094.9233553651168;1097.3799803111217;1100.6422912553453;1109.517359948425;1054.2725519391595;1174.2250114924109;1225.5526732742485;1416.0583212163797;1465.3332733606183;7254.202037775841;7265.200827908926;7283.854322913512;7313.707451701873;7381.926180738124;634.2230767310008;639.0765344077763;641.2785616181795;648.4455790299227;799.2367289238763;5640.830775076754;5783.306003279633;5884.882302354014;5898.203742494794;5907.645541267538;9282.628694852265;9401.24790016797;9446.38598491096;9497.525123743786;9518.90481095194;9404.435733855991;9408.247340212767;9435.905640943503;9443;9489.240860731124;7250.746223882139;7451.962740186264;7472.589007604634;7567.583782891884;7623.123340815877;7215.747448839265;7246.384057355184;7253.238409967089;7264.309890560388;7279.090113735783;8261.13258107914;8484.363672724447;8486.618102185294;8505.277051450448;8576.31389488827;8571.271441927256;8645.135486451305;8648.956755216184;8701.8694719578;8727.214550690214;6689.923867453934;6734.696938637871;6747.122874026345;6758.7296508139125;6772.288909664414;7734.961325193338;7754.534727916343;7770.0287464067;7788.221177882393;7810.6485208166905;7303.671334790053;7358.153812311439;7407.851842963219;7419.666115024729;7483.962580187064;6856.965715171392;6973.546719463218;6976.686049127903;6996.825079373057;7006.719731210695;7108.680109395193;7122.323379278961;7145.571265724073;7150.427965762622;7174.3184397482155;6508.511861610304;6513.902291465537;6539.869202616016;6549.672516374258;6557.737690492327;6525.086487891604;6594.934050659432;6609.603423794588;6619.437347825488;6623.768168114093 03:40:48 INFO - 2015-12-28 03:40:48,367 DEBUG : BROWSER_OUTPUT: |4;prototype.html;344.1568158012869;347.34525419584077;354.73040489228185;357.47986679381484;362.55949021938346;6293.30773614902;6366.5861718988235;6372.553921225516;6404.295527491972;6449.226092868862;6146.293176284728;6290.49676025918;6350.301466838644;6358.618482891018;6362.427381535661;4895.804167833291;4907.705537667734;4907.901841963158;4928.5564299213065;4930.975345123269;4924.827631032915;4933.210686290195;4935.950640493603;4938.283948827418;4945.431275403321;4676.97661511692;4780.282957556377;4789.880252993668;4806.279058141289;4809.5911847492835;4788.497207793183;4854.417469903617;4858.46556878743;4858.829940952085;4860.076585448771;4110.876673699794;4159.584041595816;4177.728447650893;4211.43145675333;4212.094399704079;5983.521318294526;5991.370906054889;5997.460228579449;6003.8198854034445;6022.939770602282;5593.580481463907;5607.243022191993;5608.747606357723;5612.326520817487;5613.073842815971;6548;6660.600363978128;6725.730970761164;6734.8989765153565;6738.730450781963;4627.213373726475;4637.744924029177;4649.814007439699;4667.206574882278;4677.087967846272;6892.931070689279;6938.930610693929;6980.965095174492;6989.475789315821;6998.580085194853;4783.019481006385;4784.976075119602;4789.592884604847;4790.065937142223;4799.880002999883;4821.831235906797;4846.224604063333;4849.975750121297;4917.033186725338;4960.454350021495;5652.74562644682;5660.462256085665;5668.631538949955;5675.347335056439;5677.17680936262;6788.59268443895;6790.5246632736225;6791.151106111736;6795.218549866829;6795.966020169966;1710.153474030338;1731.6623258464479;1733.4539620019652;1734.3322820714116;1735.8698097642728;1143.5425829668034;1165.8950694437542;1166.026367982727;1166.5333866453316;1169.3743847041962;6460.063290822804;6469.320721324288;6479.676016199265;6491.805245842538;6498.577592456475;6884.965575172092;6916.965415172892;6921.723131074801;6922.100126983561;6930.27232140618;6332.968335158387;6500.699860028013;6503.837404064936;6507.414332710079;6511.934880651228;3728.3475391806323;3744.850205991784;3766.7174961877968;3776.263628592398;3788.5264341957254;7219.8917016244795;7263.963680181671;7268.382187514015;7304;7317.304856038668;7277.454190935595;7283.417326613964;7289.671964761598;7294.416446684252;7303.196648368676;7148.5710857347685;7250.456215783837;7269.3094156055095;7276.417886569062;7279.781606551812;7054.188768291712;7093.503454758324;7093.822654433474;7103.431725462054;7127.75052873147;6929.341712537301;6940.167179938439;6960.269171737097;6975.79072627822;7008.7546935857;7104.786856394317;7245.855082898418;7255.709771609077;7266.455015873725;7273.9636301818155;4759.119562880878;4837.806487740591;4841.394825646794;4844.0554091951735;4846.878828029327;7044.225135235018;7089.574625522485;7098.480039585873;7100.609466479394;7100.644967751695;6714.093597364294;6851.2121106071445;6854.451643868379;6857.142857142857;6861;6817.2501024888215;6865.382115609619;6868.553544019623;6872.45020398357;6879.724811007503;6680.63256520896;6698.296678848846;6710.731570737116;6761.985702144718;6783.694733736895;6731.596104233761;6856.897146542706;6860.8284792878585;6870.587764734132;6889.793306200822;6701.731930722912;6706.295838936841;6711.161104861892;6719.328067193437;6733.461323094043 03:40:48 INFO - 2015-12-28 03:40:48,370 DEBUG : BROWSER_OUTPUT: |5;yui.html;827.9710210142642;829.9087100418952;849.5242664108096;867.2021739999201;999.1357475783445;13500.392482338293;13625.1143675661;13639.659008524792;13697.246651434167;13703.725925481484;13003.479860805557;13015.47938082478;13052.73894522109;13081.476740930375;13117.934410327935;769.0579040675184;782.5852298281891;896.2068569316169;905.9048799876;923.9445633261993;920.5075284722675;933.2114363362947;933.9533023348839;936.2322895225883;936.2837429366506;978.5303054533828;980.039561229995;980.6861804222651;982.2976571751196;982.4645568165331;971.8396464583335;972.0376826941313;975.7463059604482;979.4661909259399;980.4411485453295;716.2336300158833;720.621673621353;723.7756295548397;725.0538047847557;725.6553137259812;13980.58058258254;14055.78916316256;14105.153690778483;14109.365078571489;14138.293085345691;12850.35748212595;13163.934180329134;13275.402606882713;13382.866171338259;13707.862921370857;10999.560017599286;11035.227534072617;11052.889471105267;11189;11275.379854108021;3753.380692185786;3779;3834.405667121601;3848.0956975110826;3850.4801851749935;47564.762176188895;47941.28088078681;53235.46764532383;54231.728841355936;54318;10620.575176992988;10878.72803179911;10976.396298203515;11182.66452006441;11357.261777984404;19121.52196195106;19489;19498.025098745005;19509;19514;7785.883211751829;8003;8120.6345714443;8221.465604735793;8297.377696672773;4648.209804333272;4649.721016739007;4674.415698037746;4727.83452579165;4745.0509898019845;3262.1518405214815;3320.6015278166774;3342.6657334266865;3346.1801858544814;3474.8610055597997;649.1301655781276;653.095462784038;655.4101308822098;657.7401926239108;663.7709990053423;735.6836560279024;737.9003834482384;747.9850402991909;751.9360854327334;772.5403384985924;9931.602735890629;10378.273520853469;10518.105960993249;10611.84082238767;10684.839727404094;709.3084242863271;754.5925200391837;759.8344717555035;763.6601712238112;835.1690068381998;4292.441982542312;4462.241418958784;4485.730856148642;4495.820167193341;4537.909241815211;54361.1845822313;54407;54488;55074;55152.448475515535;49682.254766177815;50242.497575024514;50776.492235077174;51845;52377;48727.5127248723;49057.264141037915;49148.75425622849;49777.25334119991;50305;9264.44413335202;9280.257579393498;9284.118008789153;9291.21024712907;9328.113829186217;35406.291874161856;36985;37104.75467703854;37111;37280.44079338866;42741.78629106835;42871;44958.325625114994;46028.7698561505;46628.7668561655;11331.716707082389;11520.596779112691;12399.628011159679;12575;13154.736905262032;12935.159214651017;13246.072774905664;13248;13500.054996150568;13572.389242484309;12030.27818330903;12226.816597751218;12320.383980800745;12669.239845609292;12844.871551284741;12173.939130304292;12210.633680989584;12310.938445307716;12420.192687475284;12444.128910976146;11801.940990294994;11946.701332466759;11976.16166868311;12071.18161075291;12303.384830758605;10824.891751082703;10971.23201375896;11086.334819910831;11113.444327783416;11235.438228088726;10349.586016559555;10421.374717516974;10743.946280268548;10798.460076995962;10840.566377345134 03:40:48 INFO - 2015-12-28 03:40:48,370 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:40:48 INFO - 2015-12-28 03:40:48,370 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:40:48 INFO - 2015-12-28 03:40:48,371 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,285 03:40:48 INFO - 2015-12-28 03:40:48,371 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:40:48 INFO - 2015-12-28 03:40:48,371 DEBUG : BROWSER_OUTPUT: __startTimestamp1451302848359__endTimestamp 03:40:48 INFO - 2015-12-28 03:40:48,371 DEBUG : BROWSER_OUTPUT: 03:40:48 INFO - 2015-12-28 03:40:48,371 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:40:48 INFO - 2015-12-28 03:40:48,371 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:40:48 INFO - 2015-12-28 03:40:48,372 DEBUG : BROWSER_OUTPUT: 03:40:48 INFO - 2015-12-28 03:40:48,372 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5624.52 Median:5857.62 stddev:619.31 (10.6%) stddev-sans-first:594.36 03:40:48 INFO - 2015-12-28 03:40:48,372 DEBUG : BROWSER_OUTPUT: Values: 3325.2 3376.5 3388.5 3399.5 3406.4 5588.4 5631.5 5647.1 5647.4 5653.8 5584.9 5614.3 5621.6 5624.3 5666.5 5108.3 5165.8 5202.6 5242.6 5251.9 5014.1 5111.9 5113.4 5134.2 5256.5 5132.3 5141.9 5205.1 5215.6 5239.4 5196.5 5229.9 5241.6 5261.8 5304.3 4929.6 5073.8 5172.2 5180.8 5243.0 5372.5 5425.5 5434.0 5459.6 5496.4 5936.7 5938.1 5963.2 5965.0 5973.8 5922.5 5942.8 5995.2 6007.3 6029.6 5666.8 5671.1 5676.2 5688.8 5751.1 6170.0 6170.6 6175.0 6184.6 6189.4 5725.1 5725.9 5862.1 5989.4 6036.6 6024.9 6026.5 6045.9 6049.0 6073.8 5965.2 5999.6 6025.7 6029.1 6040.6 5979.0 6006.5 6060.0 6118.2 6121.5 4671.8 4672.4 4679.2 4679.6 4701.9 4042.7 4170.9 4177.1 4183.4 4202.1 5602.4 5652.8 5691.0 5739.2 5768.9 6114.3 6118.0 6166.9 6180.1 6185.8 5608.2 5798.8 5843.2 5857.6 5863.9 5139.3 5163.8 5192.1 5263.3 5304.2 6157.9 6236.3 6240.0 6241.7 6275.0 5947.4 6138.6 6139.6 6141.8 6149.7 6058.7 6069.8 6080.0 6123.1 6183.7 5974.2 6098.5 6109.6 6120.2 6138.6 5948.4 6051.5 6149.9 6190.1 6215.3 5788.2 5794.6 5798.3 5851.2 5887.4 5958.8 5982.1 5990.2 5994.2 5996.9 5667.2 5744.9 5847.9 5862.4 5917.2 5924.5 6009.7 6034.2 6071.6 6072.2 5897.3 5901.8 5915.5 5930.5 5936.9 03:40:48 INFO - 2015-12-28 03:40:48,372 DEBUG : BROWSER_OUTPUT: 03:40:48 INFO - 2015-12-28 03:40:48,372 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:49707.83 Median:37683.81 stddev:87897.92 (233.3%) stddev-sans-first:88067.10 03:40:48 INFO - 2015-12-28 03:40:48,372 DEBUG : BROWSER_OUTPUT: Values: 579.8 630.9 632.7 637.2 641.2 31482.4 39345.6 39649.4 39859.0 40112.4 44973.6 45274.0 45284.0 45510.3 45654.5 9094.4 9262.6 9269.1 9269.7 9294.8 8942.7 9083.6 9105.7 9128.0 9131.3 9050.9 9098.8 9144.0 9151.0 9170.0 9096.4 9136.5 9158.5 9164.9 9169.4 8987.7 9090.6 9107.6 9107.9 9126.0 42115.0 42350.4 42384.4 42543.1 42728.0 3687.3 4037.0 4080.7 4115.5 4181.3 31169.5 31373.8 31604.0 31615.2 31774.5 4201.6 4254.6 4256.4 4347.6 4408.0 267637.0 267763.0 420395.0 428090.0 451385.0 60104.7 60391.0 60507.0 60836.4 60866.0 61956.0 62610.1 62714.4 62717.7 62761.7 18008.2 18184.8 18285.4 18386.8 18394.7 13734.1 13848.1 13882.3 13890.4 13937.5 20857.2 21212.9 21360.4 21365.3 21389.6 7770.3 7853.7 7907.4 8026.4 8075.0 1059.6 1090.9 1114.2 1131.6 1212.4 29364.6 29501.6 30063.4 30264.8 30584.4 1123.8 1124.5 1144.2 1149.6 1245.4 15792.1 16209.8 16446.8 17114.6 17125.2 346273.0 355856.0 356242.0 356965.0 357374.0 47297.8 47399.5 47551.5 47639.5 47798.3 1424.9 1433.1 1433.3 1453.5 1458.9 28015.7 28430.7 28438.4 29024.1 29697.6 44987.1 45337.0 45369.3 45386.3 45492.1 259447.0 260627.0 262470.0 262651.0 263156.0 32838.0 32957.5 33107.0 34128.0 34708.0 39003.4 39013.0 39083.6 39764.4 40038.4 37336.0 37656.0 37711.6 37737.8 38611.2 36711.4 37170.6 37201.0 37231.6 37473.3 34131.7 34457.1 34762.3 34973.3 34983.0 30181.8 30283.4 30334.2 30374.8 30487.1 23959.6 24335.0 25318.0 26202.6 26208.0 03:40:48 INFO - 2015-12-28 03:40:48,372 DEBUG : BROWSER_OUTPUT: 03:40:48 INFO - 2015-12-28 03:40:48,372 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32835.75 Median:1963.82 stddev:107855.16 (5492.1%) stddev-sans-first:108130.17 03:40:48 INFO - 2015-12-28 03:40:48,374 DEBUG : BROWSER_OUTPUT: Values: 368.9 382.3 390.3 391.9 394.4 16123.1 17520.7 17621.9 19133.8 19324.7 11351.8 11438.3 11464.7 17205.6 17767.4 4954.8 4966.3 5050.0 5075.5 5076.5 5040.0 5246.6 5327.7 5337.4 5381.5 5292.7 5318.8 5345.7 5350.5 5464.1 5433.9 5482.1 5484.1 5495.3 5509.6 5290.0 5292.4 5315.5 5320.9 5579.7 12802.4 13148.5 13168.7 15165.8 21616.1 2237.1 2299.6 2319.4 2398.6 2436.5 9870.7 9898.7 10040.9 10189.6 10208.4 1961.6 1966.0 1969.7 1982.8 2073.4 65916.3 68208.3 68327.0 68387.7 68639.0 10578.2 10821.5 10821.8 10869.4 10874.8 14218.6 14357.7 14369.9 14384.7 14410.6 8193.6 8266.8 8308.1 8365.1 8423.1 8233.4 8233.5 8244.4 8285.0 8328.0 4578.7 4625.0 4628.2 4630.2 8313.8 3404.0 3444.4 3458.0 3462.0 3609.5 1046.0 1111.1 1114.0 1121.4 1144.1 15487.0 18078.1 18263.6 18358.4 18419.1 977.1 1011.5 1012.2 1013.7 1014.9 9592.0 10091.1 10109.6 10249.0 10263.7 645306.0 650908.0 652832.0 663888.0 688172.0 78495.0 86516.6 87010.6 87291.6 88065.6 1202.6 1216.4 1230.5 1234.5 1236.7 15569.8 15893.4 16368.9 16904.2 16986.5 34722.1 35516.6 35769.3 36203.1 39689.0 45174.1 46638.3 46916.0 47749.3 49086.0 10060.5 10166.9 10199.7 10431.9 10479.6 17611.6 18090.6 18333.7 18503.7 18509.2 12388.4 16145.8 16450.8 16463.3 16475.1 13036.1 13240.7 14507.0 15122.5 15788.9 16225.9 16366.5 16786.0 16826.0 16912.4 10074.3 10121.1 10528.4 10548.1 10548.2 10739.4 10828.2 12568.2 16333.4 16466.7 03:40:48 INFO - 2015-12-28 03:40:48,374 DEBUG : BROWSER_OUTPUT: 03:40:48 INFO - 2015-12-28 03:40:48,374 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5546.45 Median:6553.71 stddev:2843.99 (43.4%) stddev-sans-first:2836.11 03:40:48 INFO - 2015-12-28 03:40:48,374 DEBUG : BROWSER_OUTPUT: Values: 1550.6 1614.0 1623.2 1834.4 1904.1 7669.5 7830.3 7992.6 8071.3 8083.6 8021.7 8075.2 8121.5 8137.6 8194.8 2336.1 2374.8 2376.0 2377.8 2378.6 2413.6 2421.3 2479.6 2482.1 2482.1 2352.4 2355.3 2374.8 2387.8 2418.2 2356.5 2399.9 2402.1 2435.9 2440.1 2389.7 2428.5 2429.0 2429.4 2435.1 7805.7 7919.1 7939.0 7958.6 7963.3 4877.4 4918.5 4923.6 4956.8 4958.5 3170.9 3209.7 3248.1 3248.6 3248.7 958.2 972.1 990.7 1030.1 1058.8 10676.5 10708.4 10732.5 10757.1 10766.9 4256.0 4314.4 4326.4 4334.1 4341.7 8805.1 8814.2 8825.2 8828.4 8837.5 4886.8 4905.6 4911.6 4914.5 4915.8 4458.1 4497.8 4498.9 4500.2 4501.0 3519.3 3541.3 3564.9 3573.2 3573.5 1073.6 1094.9 1097.4 1100.6 1109.5 1054.3 1174.2 1225.6 1416.1 1465.3 7254.2 7265.2 7283.9 7313.7 7381.9 634.2 639.1 641.3 648.4 799.2 5640.8 5783.3 5884.9 5898.2 5907.6 9282.6 9401.2 9446.4 9497.5 9518.9 9404.4 9408.2 9435.9 9443.0 9489.2 7250.7 7452.0 7472.6 7567.6 7623.1 7215.7 7246.4 7253.2 7264.3 7279.1 8261.1 8484.4 8486.6 8505.3 8576.3 8571.3 8645.1 8649.0 8701.9 8727.2 6689.9 6734.7 6747.1 6758.7 6772.3 7735.0 7754.5 7770.0 7788.2 7810.6 7303.7 7358.2 7407.9 7419.7 7484.0 6857.0 6973.5 6976.7 6996.8 7006.7 7108.7 7122.3 7145.6 7150.4 7174.3 6508.5 6513.9 6539.9 6549.7 6557.7 6525.1 6594.9 6609.6 6619.4 6623.8 03:40:48 INFO - 2015-12-28 03:40:48,375 DEBUG : BROWSER_OUTPUT: 03:40:48 INFO - 2015-12-28 03:40:48,375 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5672.22 Median:6454.64 stddev:1718.79 (26.6%) stddev-sans-first:1676.45 03:40:48 INFO - 2015-12-28 03:40:48,376 DEBUG : BROWSER_OUTPUT: Values: 344.2 347.3 354.7 357.5 362.6 6293.3 6366.6 6372.6 6404.3 6449.2 6146.3 6290.5 6350.3 6358.6 6362.4 4895.8 4907.7 4907.9 4928.6 4931.0 4924.8 4933.2 4936.0 4938.3 4945.4 4677.0 4780.3 4789.9 4806.3 4809.6 4788.5 4854.4 4858.5 4858.8 4860.1 4110.9 4159.6 4177.7 4211.4 4212.1 5983.5 5991.4 5997.5 6003.8 6022.9 5593.6 5607.2 5608.7 5612.3 5613.1 6548.0 6660.6 6725.7 6734.9 6738.7 4627.2 4637.7 4649.8 4667.2 4677.1 6892.9 6938.9 6981.0 6989.5 6998.6 4783.0 4785.0 4789.6 4790.1 4799.9 4821.8 4846.2 4850.0 4917.0 4960.5 5652.7 5660.5 5668.6 5675.3 5677.2 6788.6 6790.5 6791.2 6795.2 6796.0 1710.2 1731.7 1733.5 1734.3 1735.9 1143.5 1165.9 1166.0 1166.5 1169.4 6460.1 6469.3 6479.7 6491.8 6498.6 6885.0 6917.0 6921.7 6922.1 6930.3 6333.0 6500.7 6503.8 6507.4 6511.9 3728.3 3744.9 3766.7 3776.3 3788.5 7219.9 7264.0 7268.4 7304.0 7317.3 7277.5 7283.4 7289.7 7294.4 7303.2 7148.6 7250.5 7269.3 7276.4 7279.8 7054.2 7093.5 7093.8 7103.4 7127.8 6929.3 6940.2 6960.3 6975.8 7008.8 7104.8 7245.9 7255.7 7266.5 7274.0 4759.1 4837.8 4841.4 4844.1 4846.9 7044.2 7089.6 7098.5 7100.6 7100.6 6714.1 6851.2 6854.5 6857.1 6861.0 6817.3 6865.4 6868.6 6872.5 6879.7 6680.6 6698.3 6710.7 6762.0 6783.7 6731.6 6856.9 6860.8 6870.6 6889.8 6701.7 6706.3 6711.2 6719.3 6733.5 03:40:48 INFO - 2015-12-28 03:40:48,376 DEBUG : BROWSER_OUTPUT: 03:40:48 INFO - 2015-12-28 03:40:48,376 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14419.12 Median:23581.72 stddev:16077.22 (68.2%) stddev-sans-first:16089.92 03:40:48 INFO - 2015-12-28 03:40:48,376 DEBUG : BROWSER_OUTPUT: Values: 828.0 829.9 849.5 867.2 999.1 13500.4 13625.1 13639.7 13697.2 13703.7 13003.5 13015.5 13052.7 13081.5 13117.9 769.1 782.6 896.2 905.9 923.9 920.5 933.2 934.0 936.2 936.3 978.5 980.0 980.7 982.3 982.5 971.8 972.0 975.7 979.5 980.4 716.2 720.6 723.8 725.1 725.7 13980.6 14055.8 14105.2 14109.4 14138.3 12850.4 13163.9 13275.4 13382.9 13707.9 10999.6 11035.2 11052.9 11189.0 11275.4 3753.4 3779.0 3834.4 3848.1 3850.5 47564.8 47941.3 53235.5 54231.7 54318.0 10620.6 10878.7 10976.4 11182.7 11357.3 19121.5 19489.0 19498.0 19509.0 19514.0 7785.9 8003.0 8120.6 8221.5 8297.4 4648.2 4649.7 4674.4 4727.8 4745.1 3262.2 3320.6 3342.7 3346.2 3474.9 649.1 653.1 655.4 657.7 663.8 735.7 737.9 748.0 751.9 772.5 9931.6 10378.3 10518.1 10611.8 10684.8 709.3 754.6 759.8 763.7 835.2 4292.4 4462.2 4485.7 4495.8 4537.9 54361.2 54407.0 54488.0 55074.0 55152.4 49682.3 50242.5 50776.5 51845.0 52377.0 48727.5 49057.3 49148.8 49777.3 50305.0 9264.4 9280.3 9284.1 9291.2 9328.1 35406.3 36985.0 37104.8 37111.0 37280.4 42741.8 42871.0 44958.3 46028.8 46628.8 11331.7 11520.6 12399.6 12575.0 13154.7 12935.2 13246.1 13248.0 13500.1 13572.4 12030.3 12226.8 12320.4 12669.2 12844.9 12173.9 12210.6 12310.9 12420.2 12444.1 11801.9 11946.7 11976.2 12071.2 12303.4 10824.9 10971.2 11086.3 11113.4 11235.4 10349.6 10421.4 10743.9 10798.5 10840.6 03:40:48 INFO - 2015-12-28 03:40:48,376 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:40:48 INFO - 2015-12-28 03:40:48,376 DEBUG : BROWSER_OUTPUT: 03:40:49 INFO - 2015-12-28 03:40:49,041 INFO : Browser exited with error code: 0 03:40:49 INFO - 2015-12-28 03:40:49,062 INFO : Completed test dromaeo_css (00:18:28) 03:40:49 INFO - 2015-12-28 03:40:49,062 INFO : Starting test kraken 03:40:49 INFO - 2015-12-28 03:40:49,062 DEBUG : operating with platform_type : linux_ 03:40:49 INFO - 2015-12-28 03:40:49,062 INFO : Initialising browser for kraken test... 03:40:49 INFO - 2015-12-28 03:40:49,068 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpG0O5Jp/profile http://localhost:43678/getInfo.html 03:40:53 INFO - 2015-12-28 03:40:53,243 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:40:53 INFO - 2015-12-28 03:40:53,244 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:40:53 INFO - 2015-12-28 03:40:53,244 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 03:40:53 INFO - 2015-12-28 03:40:53,244 DEBUG : BROWSER_OUTPUT: __metrics 03:40:54 INFO - 2015-12-28 03:40:54,165 INFO : Browser initialized. 03:40:54 INFO - 2015-12-28 03:40:54,165 INFO : Running cycle 1/1 for kraken test... 03:40:54 INFO - 2015-12-28 03:40:54,165 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpG0O5Jp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:41:05 INFO - 2015-12-28 03:41:05,982 DEBUG : BROWSER_OUTPUT: RSS: Main: 138674176 03:41:05 INFO - 2015-12-28 03:41:05,983 DEBUG : BROWSER_OUTPUT: 03:41:08 INFO - 2015-12-28 03:41:08,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43678/tests/kraken/driver.html?testName=audio-beat-detection) 03:41:09 INFO - 2015-12-28 03:41:09,080 DEBUG : BROWSER_OUTPUT: RSS: Main: 140234752 03:41:09 INFO - 2015-12-28 03:41:09,080 DEBUG : BROWSER_OUTPUT: 03:41:11 INFO - 2015-12-28 03:41:11,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43678/tests/kraken/driver.html?testName=audio-dft) 03:41:12 INFO - 2015-12-28 03:41:12,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 139931648 03:41:12 INFO - 2015-12-28 03:41:12,291 DEBUG : BROWSER_OUTPUT: 03:41:15 INFO - 2015-12-28 03:41:15,081 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43678/tests/kraken/driver.html?testName=audio-fft) 03:41:15 INFO - 2015-12-28 03:41:15,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 140247040 03:41:15 INFO - 2015-12-28 03:41:15,662 DEBUG : BROWSER_OUTPUT: 03:41:17 INFO - 2015-12-28 03:41:17,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43678/tests/kraken/driver.html?testName=audio-oscillator) 03:41:18 INFO - 2015-12-28 03:41:18,221 DEBUG : BROWSER_OUTPUT: RSS: Main: 140058624 03:41:18 INFO - 2015-12-28 03:41:18,222 DEBUG : BROWSER_OUTPUT: 03:41:20 INFO - 2015-12-28 03:41:20,403 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43678/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:41:20 INFO - 2015-12-28 03:41:20,985 DEBUG : BROWSER_OUTPUT: RSS: Main: 140226560 03:41:20 INFO - 2015-12-28 03:41:20,985 DEBUG : BROWSER_OUTPUT: 03:41:23 INFO - 2015-12-28 03:41:23,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43678/tests/kraken/driver.html?testName=imaging-darkroom) 03:41:24 INFO - 2015-12-28 03:41:24,513 DEBUG : BROWSER_OUTPUT: RSS: Main: 139427840 03:41:24 INFO - 2015-12-28 03:41:24,514 DEBUG : BROWSER_OUTPUT: 03:41:27 INFO - 2015-12-28 03:41:27,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43678/tests/kraken/driver.html?testName=imaging-desaturate) 03:41:28 INFO - 2015-12-28 03:41:28,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 139366400 03:41:28 INFO - 2015-12-28 03:41:28,409 DEBUG : BROWSER_OUTPUT: 03:41:31 INFO - 2015-12-28 03:41:31,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43678/tests/kraken/driver.html?testName=json-parse-financial) 03:41:31 INFO - 2015-12-28 03:41:31,808 DEBUG : BROWSER_OUTPUT: RSS: Main: 139476992 03:41:31 INFO - 2015-12-28 03:41:31,808 DEBUG : BROWSER_OUTPUT: 03:41:33 INFO - 2015-12-28 03:41:33,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43678/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:41:33 INFO - 2015-12-28 03:41:33,962 DEBUG : BROWSER_OUTPUT: RSS: Main: 139534336 03:41:33 INFO - 2015-12-28 03:41:33,963 DEBUG : BROWSER_OUTPUT: 03:41:35 INFO - 2015-12-28 03:41:35,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43678/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:41:36 INFO - 2015-12-28 03:41:36,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 138997760 03:41:36 INFO - 2015-12-28 03:41:36,324 DEBUG : BROWSER_OUTPUT: 03:41:38 INFO - 2015-12-28 03:41:38,336 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43678/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:41:38 INFO - 2015-12-28 03:41:38,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 138977280 03:41:38 INFO - 2015-12-28 03:41:38,925 DEBUG : BROWSER_OUTPUT: 03:41:41 INFO - 2015-12-28 03:41:41,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43678/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:41:41 INFO - 2015-12-28 03:41:41,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 139448320 03:41:41 INFO - 2015-12-28 03:41:41,906 DEBUG : BROWSER_OUTPUT: 03:41:44 INFO - 2015-12-28 03:41:44,413 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43678/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:41:45 INFO - 2015-12-28 03:41:45,006 DEBUG : BROWSER_OUTPUT: RSS: Main: 138788864 03:41:45 INFO - 2015-12-28 03:41:45,006 DEBUG : BROWSER_OUTPUT: 03:41:46 INFO - 2015-12-28 03:41:46,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43678/tests/kraken/driver.html?testName=ai-astar) 03:41:46 INFO - 2015-12-28 03:41:46,934 DEBUG : BROWSER_OUTPUT: RSS: Main: 139825152 03:41:46 INFO - 2015-12-28 03:41:46,934 DEBUG : BROWSER_OUTPUT: 03:41:46 INFO - 2015-12-28 03:41:46,937 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:41:46 INFO - 2015-12-28 03:41:46,938 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:41:46 INFO - 2015-12-28 03:41:46,938 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:41:46 INFO - 2015-12-28 03:41:46,938 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:41:46 INFO - 2015-12-28 03:41:46,938 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;105;112;110;118;119;112;113;113;112 03:41:46 INFO - 2015-12-28 03:41:46,938 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;145;128;155;164;132;148;143;123;164;124 03:41:46 INFO - 2015-12-28 03:41:46,938 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;161;159;160;161;161;160;162;161 03:41:46 INFO - 2015-12-28 03:41:46,938 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;73;73;148;72;74;72;71;151;73 03:41:46 INFO - 2015-12-28 03:41:46,939 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;92;138;92;93;92;136;92;93;143 03:41:46 INFO - 2015-12-28 03:41:46,939 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;111;110;110;109;110;109;110;110;109 03:41:46 INFO - 2015-12-28 03:41:46,939 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;147;147;147;146;146;146;147 03:41:46 INFO - 2015-12-28 03:41:46,939 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;99;95;95;96;96;96;95 03:41:46 INFO - 2015-12-28 03:41:46,939 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;60;62;62;62;63;64;70;64;60 03:41:46 INFO - 2015-12-28 03:41:46,939 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;64;63;64;63;64;65;63;64 03:41:46 INFO - 2015-12-28 03:41:46,939 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;80;81;81;81;81;81;80;82;82 03:41:46 INFO - 2015-12-28 03:41:46,940 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;114;112;120;121;121;115;123;130;115 03:41:46 INFO - 2015-12-28 03:41:46,940 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;145;150;145;146;143;144;146;143;134 03:41:46 INFO - 2015-12-28 03:41:46,940 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;73;64;66;66;66;64;69;75;64 03:41:46 INFO - 2015-12-28 03:41:46,940 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:41:46 INFO - 2015-12-28 03:41:46,940 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:41:46 INFO - 2015-12-28 03:41:46,940 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,716 03:41:46 INFO - 2015-12-28 03:41:46,940 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:41:46 INFO - 2015-12-28 03:41:46,941 DEBUG : BROWSER_OUTPUT: __startTimestamp1451302906936__endTimestamp 03:41:46 INFO - 2015-12-28 03:41:46,941 DEBUG : BROWSER_OUTPUT: 03:41:46 INFO - 2015-12-28 03:41:46,944 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:41:46 INFO - 2015-12-28 03:41:46,944 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:41:46 INFO - 2015-12-28 03:41:46,944 DEBUG : BROWSER_OUTPUT: 03:41:46 INFO - 2015-12-28 03:41:46,944 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.40 Median:112.50 stddev:3.98 (3.5%) stddev-sans-first:4.12 03:41:46 INFO - 2015-12-28 03:41:46,945 DEBUG : BROWSER_OUTPUT: Values: 110.0 105.0 112.0 110.0 118.0 119.0 112.0 113.0 113.0 112.0 03:41:46 INFO - 2015-12-28 03:41:46,945 DEBUG : BROWSER_OUTPUT: 03:41:46 INFO - 2015-12-28 03:41:46,945 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.60 Median:146.50 stddev:15.49 (10.6%) stddev-sans-first:16.41 03:41:46 INFO - 2015-12-28 03:41:46,945 DEBUG : BROWSER_OUTPUT: Values: 145.0 128.0 155.0 164.0 132.0 148.0 143.0 123.0 164.0 124.0 03:41:46 INFO - 2015-12-28 03:41:46,945 DEBUG : BROWSER_OUTPUT: 03:41:46 INFO - 2015-12-28 03:41:46,945 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 03:41:46 INFO - 2015-12-28 03:41:46,945 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 161.0 159.0 160.0 161.0 161.0 160.0 162.0 161.0 03:41:46 INFO - 2015-12-28 03:41:46,945 DEBUG : BROWSER_OUTPUT: 03:41:46 INFO - 2015-12-28 03:41:46,945 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.40 Median:73.00 stddev:32.25 (44.2%) stddev-sans-first:33.94 03:41:46 INFO - 2015-12-28 03:41:46,945 DEBUG : BROWSER_OUTPUT: Values: 77.0 73.0 73.0 148.0 72.0 74.0 72.0 71.0 151.0 73.0 03:41:46 INFO - 2015-12-28 03:41:46,945 DEBUG : BROWSER_OUTPUT: 03:41:46 INFO - 2015-12-28 03:41:46,946 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.40 Median:92.00 stddev:22.56 (24.5%) stddev-sans-first:23.41 03:41:46 INFO - 2015-12-28 03:41:46,946 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 138.0 92.0 93.0 92.0 136.0 92.0 93.0 143.0 03:41:46 INFO - 2015-12-28 03:41:46,946 DEBUG : BROWSER_OUTPUT: 03:41:46 INFO - 2015-12-28 03:41:46,946 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 03:41:46 INFO - 2015-12-28 03:41:46,946 DEBUG : BROWSER_OUTPUT: Values: 109.0 111.0 110.0 110.0 109.0 110.0 109.0 110.0 110.0 109.0 03:41:46 INFO - 2015-12-28 03:41:46,946 DEBUG : BROWSER_OUTPUT: 03:41:46 INFO - 2015-12-28 03:41:46,946 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 03:41:46 INFO - 2015-12-28 03:41:46,946 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 146.0 147.0 03:41:46 INFO - 2015-12-28 03:41:46,946 DEBUG : BROWSER_OUTPUT: 03:41:46 INFO - 2015-12-28 03:41:46,946 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.15 (1.2%) stddev-sans-first:1.22 03:41:46 INFO - 2015-12-28 03:41:46,946 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 99.0 95.0 95.0 96.0 96.0 96.0 95.0 03:41:46 INFO - 2015-12-28 03:41:46,946 DEBUG : BROWSER_OUTPUT: 03:41:46 INFO - 2015-12-28 03:41:46,947 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:62.60 Median:62.50 stddev:3.10 (5.0%) stddev-sans-first:3.00 03:41:46 INFO - 2015-12-28 03:41:46,947 DEBUG : BROWSER_OUTPUT: Values: 59.0 60.0 62.0 62.0 62.0 63.0 64.0 70.0 64.0 60.0 03:41:46 INFO - 2015-12-28 03:41:46,947 DEBUG : BROWSER_OUTPUT: 03:41:46 INFO - 2015-12-28 03:41:46,947 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.67 03:41:46 INFO - 2015-12-28 03:41:46,947 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 64.0 63.0 64.0 63.0 64.0 65.0 63.0 64.0 03:41:46 INFO - 2015-12-28 03:41:46,947 DEBUG : BROWSER_OUTPUT: 03:41:46 INFO - 2015-12-28 03:41:46,947 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:81.00 stddev:0.74 (0.9%) stddev-sans-first:0.71 03:41:46 INFO - 2015-12-28 03:41:46,948 DEBUG : BROWSER_OUTPUT: Values: 80.0 80.0 81.0 81.0 81.0 81.0 81.0 80.0 82.0 82.0 03:41:46 INFO - 2015-12-28 03:41:46,948 DEBUG : BROWSER_OUTPUT: 03:41:46 INFO - 2015-12-28 03:41:46,948 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:120.50 stddev:5.62 (4.7%) stddev-sans-first:5.61 03:41:46 INFO - 2015-12-28 03:41:46,948 DEBUG : BROWSER_OUTPUT: Values: 113.0 114.0 112.0 120.0 121.0 121.0 115.0 123.0 130.0 115.0 03:41:46 INFO - 2015-12-28 03:41:46,948 DEBUG : BROWSER_OUTPUT: 03:41:46 INFO - 2015-12-28 03:41:46,948 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.10 Median:145.00 stddev:4.95 (3.4%) stddev-sans-first:4.30 03:41:46 INFO - 2015-12-28 03:41:46,949 DEBUG : BROWSER_OUTPUT: Values: 135.0 145.0 150.0 145.0 146.0 143.0 144.0 146.0 143.0 134.0 03:41:46 INFO - 2015-12-28 03:41:46,949 DEBUG : BROWSER_OUTPUT: 03:41:46 INFO - 2015-12-28 03:41:46,949 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:67.00 stddev:3.84 (5.7%) stddev-sans-first:4.07 03:41:46 INFO - 2015-12-28 03:41:46,949 DEBUG : BROWSER_OUTPUT: Values: 68.0 73.0 64.0 66.0 66.0 66.0 64.0 69.0 75.0 64.0 03:41:46 INFO - 2015-12-28 03:41:46,949 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:41:46 INFO - 2015-12-28 03:41:46,949 DEBUG : BROWSER_OUTPUT: 03:41:47 INFO - 2015-12-28 03:41:47,777 INFO : Browser exited with error code: 0 03:41:47 INFO - 2015-12-28 03:41:47,824 INFO : Completed test kraken (00:00:58) 03:41:47 INFO - 2015-12-28 03:41:47,824 INFO : Starting test v8_7 03:41:47 INFO - 2015-12-28 03:41:47,825 DEBUG : operating with platform_type : linux_ 03:41:47 INFO - 2015-12-28 03:41:47,825 INFO : Initialising browser for v8_7 test... 03:41:47 INFO - 2015-12-28 03:41:47,831 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprok9Yq/profile http://localhost:43678/getInfo.html 03:41:51 INFO - 2015-12-28 03:41:51,923 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:41:51 INFO - 2015-12-28 03:41:51,923 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:41:51 INFO - 2015-12-28 03:41:51,923 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 03:41:51 INFO - 2015-12-28 03:41:51,923 DEBUG : BROWSER_OUTPUT: __metrics 03:41:52 INFO - 2015-12-28 03:41:52,853 INFO : Browser initialized. 03:41:52 INFO - 2015-12-28 03:41:52,853 INFO : Running cycle 1/1 for v8_7 test... 03:41:52 INFO - 2015-12-28 03:41:52,853 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprok9Yq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:42:04 INFO - 2015-12-28 03:42:04,650 DEBUG : BROWSER_OUTPUT: RSS: Main: 138244096 03:42:04 INFO - 2015-12-28 03:42:04,650 DEBUG : BROWSER_OUTPUT: 03:42:26 INFO - 2015-12-28 03:42:26,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:43678/tests/v8_7/run.html (next: http://localhost:43678/tests/v8_7/run.html) 03:42:26 INFO - 2015-12-28 03:42:26,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 136699904 03:42:26 INFO - 2015-12-28 03:42:26,255 DEBUG : BROWSER_OUTPUT: 03:42:26 INFO - 2015-12-28 03:42:26,255 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:42:26 INFO - 2015-12-28 03:42:26,255 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:42:26 INFO - 2015-12-28 03:42:26,255 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:42:26 INFO - 2015-12-28 03:42:26,256 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:42:26 INFO - 2015-12-28 03:42:26,256 DEBUG : BROWSER_OUTPUT: |0;Richards;166.88918558077435 03:42:26 INFO - 2015-12-28 03:42:26,256 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.6944490748458 03:42:26 INFO - 2015-12-28 03:42:26,256 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.17364600781684 03:42:26 INFO - 2015-12-28 03:42:26,256 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5164.948453608247 03:42:26 INFO - 2015-12-28 03:42:26,256 DEBUG : BROWSER_OUTPUT: |4;RayTrace;937.207122774133 03:42:26 INFO - 2015-12-28 03:42:26,256 DEBUG : BROWSER_OUTPUT: |5;Earley;544.3658138268917 03:42:26 INFO - 2015-12-28 03:42:26,256 DEBUG : BROWSER_OUTPUT: |6;Boyer;10680.851063829787 03:42:26 INFO - 2015-12-28 03:42:26,256 DEBUG : BROWSER_OUTPUT: |7;RegExp;23833.333333333332 03:42:26 INFO - 2015-12-28 03:42:26,257 DEBUG : BROWSER_OUTPUT: |8;Splay;530.7855626326964 03:42:26 INFO - 2015-12-28 03:42:26,257 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 03:42:26 INFO - 2015-12-28 03:42:26,257 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:42:26 INFO - 2015-12-28 03:42:26,257 DEBUG : BROWSER_OUTPUT: __startTimestamp1451302946252__endTimestamp 03:42:26 INFO - 2015-12-28 03:42:26,257 DEBUG : BROWSER_OUTPUT: 03:42:26 INFO - 2015-12-28 03:42:26,257 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:42:26 INFO - 2015-12-28 03:42:26,257 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:42:26 INFO - 2015-12-28 03:42:26,257 DEBUG : BROWSER_OUTPUT: 03:42:26 INFO - 2015-12-28 03:42:26,257 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.89 Median:166.89 stddev:0.00 (0.0%) 03:42:26 INFO - 2015-12-28 03:42:26,257 DEBUG : BROWSER_OUTPUT: Values: 166.9 03:42:26 INFO - 2015-12-28 03:42:26,257 DEBUG : BROWSER_OUTPUT: 03:42:26 INFO - 2015-12-28 03:42:26,257 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.69 Median:166.69 stddev:0.00 (0.0%) 03:42:26 INFO - 2015-12-28 03:42:26,257 DEBUG : BROWSER_OUTPUT: Values: 166.7 03:42:26 INFO - 2015-12-28 03:42:26,257 DEBUG : BROWSER_OUTPUT: 03:42:26 INFO - 2015-12-28 03:42:26,257 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.17 Median:279.17 stddev:0.00 (0.0%) 03:42:26 INFO - 2015-12-28 03:42:26,257 DEBUG : BROWSER_OUTPUT: Values: 279.2 03:42:26 INFO - 2015-12-28 03:42:26,258 DEBUG : BROWSER_OUTPUT: 03:42:26 INFO - 2015-12-28 03:42:26,258 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5164.95 Median:5164.95 stddev:0.00 (0.0%) 03:42:26 INFO - 2015-12-28 03:42:26,258 DEBUG : BROWSER_OUTPUT: Values: 5164.9 03:42:26 INFO - 2015-12-28 03:42:26,258 DEBUG : BROWSER_OUTPUT: 03:42:26 INFO - 2015-12-28 03:42:26,258 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:937.21 Median:937.21 stddev:0.00 (0.0%) 03:42:26 INFO - 2015-12-28 03:42:26,258 DEBUG : BROWSER_OUTPUT: Values: 937.2 03:42:26 INFO - 2015-12-28 03:42:26,258 DEBUG : BROWSER_OUTPUT: 03:42:26 INFO - 2015-12-28 03:42:26,258 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:544.37 Median:544.37 stddev:0.00 (0.0%) 03:42:26 INFO - 2015-12-28 03:42:26,258 DEBUG : BROWSER_OUTPUT: Values: 544.4 03:42:26 INFO - 2015-12-28 03:42:26,258 DEBUG : BROWSER_OUTPUT: 03:42:26 INFO - 2015-12-28 03:42:26,258 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10680.85 Median:10680.85 stddev:0.00 (0.0%) 03:42:26 INFO - 2015-12-28 03:42:26,259 DEBUG : BROWSER_OUTPUT: Values: 10680.9 03:42:26 INFO - 2015-12-28 03:42:26,259 DEBUG : BROWSER_OUTPUT: 03:42:26 INFO - 2015-12-28 03:42:26,259 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23833.33 Median:23833.33 stddev:0.00 (0.0%) 03:42:26 INFO - 2015-12-28 03:42:26,259 DEBUG : BROWSER_OUTPUT: Values: 23833.3 03:42:26 INFO - 2015-12-28 03:42:26,259 DEBUG : BROWSER_OUTPUT: 03:42:26 INFO - 2015-12-28 03:42:26,259 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:530.79 Median:530.79 stddev:0.00 (0.0%) 03:42:26 INFO - 2015-12-28 03:42:26,259 DEBUG : BROWSER_OUTPUT: Values: 530.8 03:42:26 INFO - 2015-12-28 03:42:26,259 DEBUG : BROWSER_OUTPUT: 03:42:26 INFO - 2015-12-28 03:42:26,259 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 03:42:26 INFO - 2015-12-28 03:42:26,260 DEBUG : BROWSER_OUTPUT: Values: 4840.6 03:42:26 INFO - 2015-12-28 03:42:26,260 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:42:26 INFO - 2015-12-28 03:42:26,260 DEBUG : BROWSER_OUTPUT: 03:42:27 INFO - 2015-12-28 03:42:27,057 INFO : Browser exited with error code: 0 03:42:27 INFO - 2015-12-28 03:42:27,074 INFO : Completed test v8_7 (00:00:39) 03:42:27 INFO - 2015-12-28 03:42:27,329 INFO : Completed test suite (00:20:06) 03:42:27 INFO - 2015-12-28 03:42:27,329 DEBUG : Working with test: dromaeo_css 03:42:27 INFO - 2015-12-28 03:42:27,329 DEBUG : Generating results file: dromaeo_css 03:42:27 INFO - 2015-12-28 03:42:27,331 DEBUG : Working with test: kraken 03:42:27 INFO - 2015-12-28 03:42:27,331 DEBUG : Generating results file: kraken 03:42:27 INFO - 2015-12-28 03:42:27,331 INFO : javascript benchmark 03:42:27 INFO - 2015-12-28 03:42:27,331 DEBUG : Working with test: v8_7 03:42:27 INFO - 2015-12-28 03:42:27,332 DEBUG : Generating results file: v8_7 03:42:27 INFO - 2015-12-28 03:42:27,332 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:42:27 INFO - 2015-12-28 03:42:27,375 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 03:42:27 INFO - 2015-12-28 03:42:27,375 DEBUG : process_Request line: dromaeo_css 7392.15 graph.html#tests=[[72,52,43]] 03:42:27 INFO - 2015-12-28 03:42:27,376 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:42:27 INFO - 2015-12-28 03:42:27,400 DEBUG : process_Request line: kraken 1499.20 graph.html#tests=[[232,52,43]] 03:42:27 INFO - 2015-12-28 03:42:27,400 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:42:27 INFO - 2015-12-28 03:42:27,426 DEBUG : process_Request line: v8_7 23266.22 graph.html#tests=[[230,52,43]] 03:42:27 INFO - 2015-12-28 03:42:27,427 INFO : javascript benchmark 03:42:27 INFO - 2015-12-28 03:42:27,431 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3325.1520862180146, 3376.5441665375165, 3388.542546756187, 3399.4900764885265, 3406.437937740273, 5588.357338906027, 5631.465010823976, 5647.068233741433, 5647.3505546862125, 5653.802116925908, 5584.86037849054, 5614.27014488117, 5621.578381621374, 5624.325080990287, 5666.546676265899, 5108.259302401149, 5165.81919632813, 5202.635815492917, 5242.55438287746, 5251.870847767729, 5014.097462456756, 5111.897762044757, 5113.360829896263, 5134.229865520183, 5256.474352564732, 5132.307138536287, 5141.922871156936, 5205.141151709963, 5215.556677682402, 5239.3712754469325, 5196.506331898482, 5229.947700523003, 5241.606879484054, 5261.76322065508, 5304.283921670563, 4929.556339929388, 5073.847784566469, 5172.19830926207, 5180.766865491062, 5242.973785131088, 5372.489613486712, 5425.457454254582, 5434.0, 5459.617826752129, 5496.395396506381, 5936.7031648417405, 5938.10928360745, 5963.165156878041, 5964.97017514914, 5973.761049558012, 5922.526197904201, 5942.821715348547, 5995.160677505153, 6007.339192688801, 6029.60807547508, 5666.801661941812, 5671.092625179951, 5676.233708449347, 5688.800891968803, 5751.05107657236, 6170.0, 6170.642458659087, 6174.969125154345, 6184.567080304426, 6189.442950134509, 5725.141228815628, 5725.885482290331, 5862.12068189775, 5989.371116032754, 6036.63780173191, 6024.939750602525, 6026.487748541423, 6045.879082418327, 6048.9697551512845, 6073.848153796191, 5965.164876917235, 5999.640021598718, 6025.6685882276015, 6029.125776762433, 6040.577159598786, 5979.0, 6006.519478441714, 6060.0, 6118.223266370627, 6121.54443000217, 4671.8364857229835, 4672.43930728308, 4679.22792739201, 4679.64902632304, 4701.858944231679, 4042.6765858731233, 4170.937435938464, 4177.10192308649, 4183.3515805050265, 4202.075543380452, 5602.411746766612, 5652.7738890443925, 5690.97562438765, 5739.196512488255, 5768.913466298009, 6114.296855861544, 6118.0, 6166.907496387557, 6180.072989051589, 6185.8144255672405, 5608.242887210175, 5798.768049278066, 5843.211166492554, 5857.6192547485125, 5863.941360586339, 5139.280500729901, 5163.7676304566385, 5192.143296356135, 5263.34208223972, 5304.177852432879, 6157.907631385533, 6236.345183755731, 6240.032794916795, 6241.719122639402, 6275.0, 5947.434993675767, 6138.631682099178, 6139.570230083851, 6141.8464538385115, 6149.723262453111, 6058.7273572688455, 6069.787557435468, 6080.0, 6123.050927106306, 6183.721732522137, 5974.193483879794, 6098.512119030555, 6109.633421994695, 6120.173776540289, 6138.631682099089, 5948.375420580776, 6051.455369016633, 6149.947034422519, 6190.133381326528, 6215.285242197205, 5788.218590490398, 5794.62334948227, 5798.333191682842, 5851.239338886088, 5887.411258874078, 5958.791442299672, 5982.0727787193055, 5990.221271234712, 5994.220751302303, 5996.8800623988145, 5667.20659107717, 5744.885102298014, 5847.883042339215, 5862.355140934579, 5917.201177841109, 5924.4667979882015, 6009.699515024318, 6034.24571928509, 6071.635701857903, 6072.210612620331, 5897.262842144732, 5901.793437229848, 5915.467607915309, 5930.525557955267, 5936.851578710567], "unit": "ms", "name": "dojo.html", "value": 5584.52995237567}, {"lowerIsBetter": false, "replicates": [579.7854793726322, 630.9211248764612, 632.7310892870529, 637.1589501857547, 641.249737806766, 31482.370352592934, 39345.60654393459, 39649.40525892114, 39859.0, 40112.398314025275, 44973.550264497346, 45274.0, 45284.0, 45510.31734523985, 45654.54345456544, 9094.408863423872, 9262.583183756748, 9269.073092690744, 9269.721908342726, 9294.767630809216, 8942.687005954793, 9083.636654533844, 9105.726828195166, 9128.041555636662, 9131.26949844011, 9050.909490905073, 9098.818023639524, 9144.0, 9150.954245228764, 9170.0, 9096.363254572183, 9136.45181289118, 9158.496282704482, 9164.908350916505, 9169.40398874071, 8987.730368088902, 9090.63637454501, 9107.63569457221, 9107.863382049274, 9125.996140424548, 42115.0, 42350.36474452886, 42384.36423453651, 42543.149137017084, 42728.0, 3687.3178461984617, 4037.0, 4080.6735461163335, 4115.54728979812, 4181.310083836163, 31169.532457013163, 31373.84313078443, 31604.0, 31615.20961975946, 31774.523382149287, 4201.642860356873, 4254.638355739766, 4256.382824490432, 4347.630451411602, 4407.955920440787, 267637.0, 267763.0, 420395.0, 428090.0, 451385.0, 60104.69947650234, 60391.0, 60507.0, 60836.39163608396, 60866.0, 61956.0, 62610.0608490873, 62714.372856271766, 62717.68641156856, 62761.68619156875, 18008.189631466616, 18184.818151818312, 18285.360012399502, 18386.81613183878, 18394.724079138825, 13734.107283026571, 13848.09987350819, 13882.305884705724, 13890.4443822248, 13937.512187073404, 20857.1657133716, 21212.893935530225, 21360.35918922435, 21365.25221617236, 21389.572208555743, 7770.261825126604, 7853.725119620786, 7907.369388540086, 8026.398020148512, 8074.959625201954, 1059.5708737961138, 1090.8854570270007, 1114.1866437500507, 1131.643532287327, 1212.3812564859861, 29364.559531607043, 29501.557476637867, 30063.398732025675, 30264.84867575648, 30584.38831223363, 1123.842662027317, 1124.4771181400688, 1144.2047776795048, 1149.5689116581282, 1245.3897590180927, 15792.131432771308, 16209.756853647204, 16446.75329870053, 17114.572135696708, 17125.22936467862, 346273.0, 355856.0, 356242.0, 356965.0, 357374.0, 47297.763511182224, 47399.52600473951, 47551.52448475471, 47639.5236047642, 47798.283025754645, 1424.8717615414662, 1433.089987857697, 1433.2976841347872, 1453.549399686122, 1458.9197594132213, 28015.719842802126, 28430.71569284281, 28438.43123137567, 29024.129276121752, 29697.554536681535, 44987.10025799531, 45337.0, 45369.319460207465, 45386.319205211286, 45492.09015819599, 259447.0, 260627.0, 262470.0, 262651.0, 263156.0, 32838.0, 32957.50563741498, 33107.0, 34128.0, 34708.0, 39003.41494877522, 39013.0, 39083.609163908, 39764.40353394643, 40038.39942400808, 37336.0, 37656.0, 37711.62288377191, 37737.81131094327, 38611.227775444895, 36711.43752369984, 37170.62829371672, 37201.0, 37231.6276837239, 37473.250534988605, 34131.65868341285, 34457.138571535914, 34762.304753905286, 34973.300533989684, 34983.0, 30181.849090754407, 30283.394332113676, 30334.241643959078, 30374.84812575923, 30487.085387438412, 23959.640605390585, 24335.0, 25318.0, 26202.60696089522, 26208.0], "unit": "ms", "name": "ext.html", "value": 19437.060647553488}, {"lowerIsBetter": false, "replicates": [368.85798967397545, 382.25269597936057, 390.3188935307887, 391.8550136449513, 394.3965732429384, 16123.113228772441, 17520.737188942177, 17621.911890440562, 19133.808661913376, 19324.710129348052, 11351.772964540703, 11438.313701177934, 11464.71338216543, 17205.569860753487, 17767.378141765043, 4954.801807927679, 4966.255061740731, 5049.9747501262445, 5075.467075957026, 5076.543111119999, 5039.974800125994, 5246.554042906358, 5327.680339179642, 5337.412884582693, 5381.5425688816495, 5292.682439053649, 5318.787248510055, 5345.679259244438, 5350.464953504657, 5464.0711079116645, 5433.918491222596, 5482.068048431756, 5484.122540393538, 5495.258140151069, 5509.614326997112, 5290.0477913975465, 5292.364916210041, 5315.495027972375, 5320.920186197211, 5579.7489112990015, 12802.423890924838, 13148.474061037547, 13168.6707832304, 15165.848341516554, 21616.135354585796, 2237.0827960536103, 2299.5630830142386, 2319.362175401778, 2398.604230301998, 2436.537057958982, 9870.654527091589, 9898.653547125889, 10040.94979525105, 10189.59241630334, 10208.438535880523, 1961.63709713702, 1966.0071663809827, 1969.7340858983996, 1982.7818939916742, 2073.3676228750223, 65916.3408365915, 68208.3179168212, 68327.0, 68387.65806170937, 68639.0, 10578.206634502443, 10821.458927053773, 10821.783564328827, 10869.402182880018, 10874.782504349869, 14218.644533886736, 14357.712845743026, 14369.928150359181, 14384.712305753827, 14410.639734006523, 8193.590320483952, 8266.751997440086, 8308.086110527836, 8365.1216622255, 8423.073461919184, 8233.3824963128, 8233.50598964064, 8244.422890397615, 8284.958575207205, 8327.958360208282, 4578.702384345007, 4624.953750462452, 4628.213203755369, 4630.21286381316, 8313.750587482386, 3404.0, 3444.3800115979366, 3457.9654203457644, 3461.9653803462147, 3609.4585812127866, 1045.9529321180564, 1111.1222134513805, 1114.0, 1121.3720316622716, 1144.1476100305326, 15487.0, 18078.09609519519, 18263.63472730538, 18358.449246522625, 18419.079046047646, 977.1449981266392, 1011.4993078426226, 1012.2256473797551, 1013.6654903881702, 1014.898510148994, 9592.0, 10091.091801737879, 10109.64616238428, 10248.97510248984, 10263.7434064149, 645306.0, 650908.0, 652832.0, 663888.0, 688172.0, 78495.0, 86516.56741716251, 87010.56494717613, 87291.56354218189, 88065.55967220123, 1202.5851081376911, 1216.403962058585, 1230.4585982167816, 1234.456838990859, 1236.6970092327258, 15569.76645350298, 15893.443729469413, 16368.918155409146, 16904.154792260582, 16986.490405287863, 34722.13194670052, 35516.644833551334, 35769.28461430705, 36203.09492262715, 39689.0, 45174.09651807011, 46638.30042549297, 46916.0, 47749.283760742925, 49086.0, 10060.49697515136, 10166.88164301941, 10199.694009179737, 10431.852496225258, 10479.580816767244, 17611.559711006816, 18090.63818723592, 18333.724994124834, 18503.722444163617, 18509.167087480826, 12388.442520086797, 16145.75781363304, 16450.83549164541, 16463.34146634121, 16475.093869836794, 13036.087473876738, 13240.668983275495, 14507.0, 15122.54632361031, 15788.921055394649, 16225.918870405572, 16366.509004729876, 16786.0, 16826.0, 16912.408065717642, 10074.345167564084, 10121.139703125316, 10528.420936848546, 10548.103411209826, 10548.156147508334, 10739.409332486475, 10828.242023058625, 12568.245905245714, 16333.428330008393, 16466.67066658684], "unit": "ms", "name": "jquery.html", "value": 9471.50546764671}, {"lowerIsBetter": false, "replicates": [1550.620098075971, 1613.9838601613994, 1623.2127418202174, 1834.4404956488274, 1904.1145867171772, 7669.463137580372, 7830.334421574159, 7992.560409177493, 8071.273585377322, 8083.555404452753, 8021.719239826607, 8075.192480751936, 8121.51270923745, 8137.552434616094, 8194.754157375273, 2336.0655737704883, 2374.833761636686, 2376.0495801679294, 2377.821663375245, 2378.5599664062206, 2413.625887987356, 2421.322029831641, 2479.5536803375385, 2482.0816297969777, 2482.118847809029, 2352.3766201956496, 2355.3287313115766, 2374.8218883583713, 2387.8328517003815, 2418.2140804238607, 2356.5286942611547, 2399.9280021599293, 2402.0752010476003, 2435.902563897442, 2440.1093600835743, 2389.689340385756, 2428.477877256398, 2428.9757102428925, 2429.356220601542, 2435.111184417675, 7805.687772489094, 7919.128895821455, 7938.960305198437, 7958.6418611162635, 7963.3231175350165, 4877.3903262092235, 4918.458969513351, 4923.58149557288, 4956.826511072095, 4958.454569997298, 3170.936581268385, 3209.711125998648, 3248.13924310058, 3248.6101667800017, 3248.658890816454, 958.242988039448, 972.0862389353985, 990.7374545745383, 1030.0832259289239, 1058.751193469534, 10676.466176691212, 10708.41103739294, 10732.517036733288, 10757.085647719954, 10766.946165269124, 4256.0, 4314.395984562164, 4326.372675961968, 4334.111507141029, 4341.739495630272, 8805.075467075865, 8814.206721395105, 8825.205731484197, 8828.38201325901, 8837.513936733412, 4886.780094895738, 4905.632077594195, 4911.631627627942, 4914.483979182134, 4915.778789954461, 4458.08609235106, 4497.797599108048, 4498.910021799611, 4500.234960056799, 4501.0, 3519.348920449725, 3541.29174165168, 3564.928701426009, 3573.213892943548, 3573.5354403927845, 1073.581303291717, 1094.9233553651168, 1097.3799803111217, 1100.6422912553453, 1109.517359948425, 1054.2725519391595, 1174.2250114924109, 1225.5526732742485, 1416.0583212163797, 1465.3332733606183, 7254.202037775841, 7265.200827908926, 7283.854322913512, 7313.707451701873, 7381.926180738124, 634.2230767310008, 639.0765344077763, 641.2785616181795, 648.4455790299227, 799.2367289238763, 5640.830775076754, 5783.306003279633, 5884.882302354014, 5898.203742494794, 5907.645541267538, 9282.628694852265, 9401.24790016797, 9446.38598491096, 9497.525123743786, 9518.90481095194, 9404.435733855991, 9408.247340212767, 9435.905640943503, 9443.0, 9489.240860731124, 7250.746223882139, 7451.962740186264, 7472.589007604634, 7567.583782891884, 7623.123340815877, 7215.747448839265, 7246.384057355184, 7253.238409967089, 7264.309890560388, 7279.090113735783, 8261.13258107914, 8484.363672724447, 8486.618102185294, 8505.277051450448, 8576.31389488827, 8571.271441927256, 8645.135486451305, 8648.956755216184, 8701.8694719578, 8727.214550690214, 6689.923867453934, 6734.696938637871, 6747.122874026345, 6758.7296508139125, 6772.288909664414, 7734.961325193338, 7754.534727916343, 7770.0287464067, 7788.221177882393, 7810.6485208166905, 7303.671334790053, 7358.153812311439, 7407.851842963219, 7419.666115024729, 7483.962580187064, 6856.965715171392, 6973.546719463218, 6976.686049127903, 6996.825079373057, 7006.719731210695, 7108.680109395193, 7122.323379278961, 7145.571265724073, 7150.427965762622, 7174.3184397482155, 6508.511861610304, 6513.902291465537, 6539.869202616016, 6549.672516374258, 6557.737690492327, 6525.086487891604, 6594.934050659432, 6609.603423794588, 6619.437347825488, 6623.768168114093], "unit": "ms", "name": "mootools.html", "value": 4529.843607465127}, {"lowerIsBetter": false, "replicates": [344.1568158012869, 347.34525419584077, 354.73040489228185, 357.47986679381484, 362.55949021938346, 6293.30773614902, 6366.5861718988235, 6372.553921225516, 6404.295527491972, 6449.226092868862, 6146.293176284728, 6290.49676025918, 6350.301466838644, 6358.618482891018, 6362.427381535661, 4895.804167833291, 4907.705537667734, 4907.901841963158, 4928.5564299213065, 4930.975345123269, 4924.827631032915, 4933.210686290195, 4935.950640493603, 4938.283948827418, 4945.431275403321, 4676.97661511692, 4780.282957556377, 4789.880252993668, 4806.279058141289, 4809.5911847492835, 4788.497207793183, 4854.417469903617, 4858.46556878743, 4858.829940952085, 4860.076585448771, 4110.876673699794, 4159.584041595816, 4177.728447650893, 4211.43145675333, 4212.094399704079, 5983.521318294526, 5991.370906054889, 5997.460228579449, 6003.8198854034445, 6022.939770602282, 5593.580481463907, 5607.243022191993, 5608.747606357723, 5612.326520817487, 5613.073842815971, 6548.0, 6660.600363978128, 6725.730970761164, 6734.8989765153565, 6738.730450781963, 4627.213373726475, 4637.744924029177, 4649.814007439699, 4667.206574882278, 4677.087967846272, 6892.931070689279, 6938.930610693929, 6980.965095174492, 6989.475789315821, 6998.580085194853, 4783.019481006385, 4784.976075119602, 4789.592884604847, 4790.065937142223, 4799.880002999883, 4821.831235906797, 4846.224604063333, 4849.975750121297, 4917.033186725338, 4960.454350021495, 5652.74562644682, 5660.462256085665, 5668.631538949955, 5675.347335056439, 5677.17680936262, 6788.59268443895, 6790.5246632736225, 6791.151106111736, 6795.218549866829, 6795.966020169966, 1710.153474030338, 1731.6623258464479, 1733.4539620019652, 1734.3322820714116, 1735.8698097642728, 1143.5425829668034, 1165.8950694437542, 1166.026367982727, 1166.5333866453316, 1169.3743847041962, 6460.063290822804, 6469.320721324288, 6479.676016199265, 6491.805245842538, 6498.577592456475, 6884.965575172092, 6916.965415172892, 6921.723131074801, 6922.100126983561, 6930.27232140618, 6332.968335158387, 6500.699860028013, 6503.837404064936, 6507.414332710079, 6511.934880651228, 3728.3475391806323, 3744.850205991784, 3766.7174961877968, 3776.263628592398, 3788.5264341957254, 7219.8917016244795, 7263.963680181671, 7268.382187514015, 7304.0, 7317.304856038668, 7277.454190935595, 7283.417326613964, 7289.671964761598, 7294.416446684252, 7303.196648368676, 7148.5710857347685, 7250.456215783837, 7269.3094156055095, 7276.417886569062, 7279.781606551812, 7054.188768291712, 7093.503454758324, 7093.822654433474, 7103.431725462054, 7127.75052873147, 6929.341712537301, 6940.167179938439, 6960.269171737097, 6975.79072627822, 7008.7546935857, 7104.786856394317, 7245.855082898418, 7255.709771609077, 7266.455015873725, 7273.9636301818155, 4759.119562880878, 4837.806487740591, 4841.394825646794, 4844.0554091951735, 4846.878828029327, 7044.225135235018, 7089.574625522485, 7098.480039585873, 7100.609466479394, 7100.644967751695, 6714.093597364294, 6851.2121106071445, 6854.451643868379, 6857.142857142857, 6861.0, 6817.2501024888215, 6865.382115609619, 6868.553544019623, 6872.45020398357, 6879.724811007503, 6680.63256520896, 6698.296678848846, 6710.731570737116, 6761.985702144718, 6783.694733736895, 6731.596104233761, 6856.897146542706, 6860.8284792878585, 6870.587764734132, 6889.793306200822, 6701.731930722912, 6706.295838936841, 6711.161104861892, 6719.328067193437, 6733.461323094043], "unit": "ms", "name": "prototype.html", "value": 5112.742961357055}, {"lowerIsBetter": false, "replicates": [827.9710210142642, 829.9087100418952, 849.5242664108096, 867.2021739999201, 999.1357475783445, 13500.392482338293, 13625.1143675661, 13639.659008524792, 13697.246651434167, 13703.725925481484, 13003.479860805557, 13015.47938082478, 13052.73894522109, 13081.476740930375, 13117.934410327935, 769.0579040675184, 782.5852298281891, 896.2068569316169, 905.9048799876, 923.9445633261993, 920.5075284722675, 933.2114363362947, 933.9533023348839, 936.2322895225883, 936.2837429366506, 978.5303054533828, 980.039561229995, 980.6861804222651, 982.2976571751196, 982.4645568165331, 971.8396464583335, 972.0376826941313, 975.7463059604482, 979.4661909259399, 980.4411485453295, 716.2336300158833, 720.621673621353, 723.7756295548397, 725.0538047847557, 725.6553137259812, 13980.58058258254, 14055.78916316256, 14105.153690778483, 14109.365078571489, 14138.293085345691, 12850.35748212595, 13163.934180329134, 13275.402606882713, 13382.866171338259, 13707.862921370857, 10999.560017599286, 11035.227534072617, 11052.889471105267, 11189.0, 11275.379854108021, 3753.380692185786, 3779.0, 3834.405667121601, 3848.0956975110826, 3850.4801851749935, 47564.762176188895, 47941.28088078681, 53235.46764532383, 54231.728841355936, 54318.0, 10620.575176992988, 10878.72803179911, 10976.396298203515, 11182.66452006441, 11357.261777984404, 19121.52196195106, 19489.0, 19498.025098745005, 19509.0, 19514.0, 7785.883211751829, 8003.0, 8120.6345714443, 8221.465604735793, 8297.377696672773, 4648.209804333272, 4649.721016739007, 4674.415698037746, 4727.83452579165, 4745.0509898019845, 3262.1518405214815, 3320.6015278166774, 3342.6657334266865, 3346.1801858544814, 3474.8610055597997, 649.1301655781276, 653.095462784038, 655.4101308822098, 657.7401926239108, 663.7709990053423, 735.6836560279024, 737.9003834482384, 747.9850402991909, 751.9360854327334, 772.5403384985924, 9931.602735890629, 10378.273520853469, 10518.105960993249, 10611.84082238767, 10684.839727404094, 709.3084242863271, 754.5925200391837, 759.8344717555035, 763.6601712238112, 835.1690068381998, 4292.441982542312, 4462.241418958784, 4485.730856148642, 4495.820167193341, 4537.909241815211, 54361.1845822313, 54407.0, 54488.0, 55074.0, 55152.448475515535, 49682.254766177815, 50242.497575024514, 50776.492235077174, 51845.0, 52377.0, 48727.5127248723, 49057.264141037915, 49148.75425622849, 49777.25334119991, 50305.0, 9264.44413335202, 9280.257579393498, 9284.118008789153, 9291.21024712907, 9328.113829186217, 35406.291874161856, 36985.0, 37104.75467703854, 37111.0, 37280.44079338866, 42741.78629106835, 42871.0, 44958.325625114994, 46028.7698561505, 46628.7668561655, 11331.716707082389, 11520.596779112691, 12399.628011159679, 12575.0, 13154.736905262032, 12935.159214651017, 13246.072774905664, 13248.0, 13500.054996150568, 13572.389242484309, 12030.27818330903, 12226.816597751218, 12320.383980800745, 12669.239845609292, 12844.871551284741, 12173.939130304292, 12210.633680989584, 12310.938445307716, 12420.192687475284, 12444.128910976146, 11801.940990294994, 11946.701332466759, 11976.16166868311, 12071.18161075291, 12303.384830758605, 10824.891751082703, 10971.23201375896, 11086.334819910831, 11113.444327783416, 11235.438228088726, 10349.586016559555, 10421.374717516974, 10743.946280268548, 10798.460076995962, 10840.566377345134], "unit": "ms", "name": "yui.html", "value": 6851.937236436934}], "name": "dromaeo_css", "value": 7392.149424098743}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 112.0, 110.0, 118.0, 119.0, 112.0, 113.0, 113.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 112.4}, {"lowerIsBetter": true, "replicates": [145.0, 128.0, 155.0, 164.0, 132.0, 148.0, 143.0, 123.0, 164.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.6}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 159.0, 160.0, 161.0, 161.0, 160.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [77.0, 73.0, 73.0, 148.0, 72.0, 74.0, 72.0, 71.0, 151.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 88.4}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 138.0, 92.0, 93.0, 92.0, 136.0, 92.0, 93.0, 143.0], "unit": "ms", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 99.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 62.0, 62.0, 62.0, 63.0, 64.0, 70.0, 64.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 62.6}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0, 65.0, 63.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [80.0, 80.0, 81.0, 81.0, 81.0, 81.0, 81.0, 80.0, 82.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 80.9}, {"lowerIsBetter": true, "replicates": [113.0, 114.0, 112.0, 120.0, 121.0, 121.0, 115.0, 123.0, 130.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [135.0, 145.0, 150.0, 145.0, 146.0, 143.0, 144.0, 146.0, 143.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.1}, {"lowerIsBetter": true, "replicates": [68.0, 73.0, 64.0, 66.0, 66.0, 66.0, 64.0, 69.0, 75.0, 64.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.5}], "name": "kraken", "value": 1499.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.88918558077435], "unit": "score", "name": "Richards", "value": 211.52958400000006}, {"lowerIsBetter": false, "replicates": [166.6944490748458], "unit": "score", "name": "DeltaBlue", "value": 396.64188200000007}, {"lowerIsBetter": false, "replicates": [279.17364600781684], "unit": "score", "name": "Encrypt", "value": 953.4603419999996}, {"lowerIsBetter": false, "replicates": [5164.948453608247], "unit": "score", "name": "Decrypt", "value": 51.53604191616765}, {"lowerIsBetter": false, "replicates": [937.207122774133], "unit": "score", "name": "RayTrace", "value": 789.568263}, {"lowerIsBetter": false, "replicates": [544.3658138268917], "unit": "score", "name": "Earley", "value": 1224.2925309999998}, {"lowerIsBetter": false, "replicates": [10680.851063829787], "unit": "score", "name": "Boyer", "value": 62.397930278884424}, {"lowerIsBetter": false, "replicates": [23833.333333333332], "unit": "score", "name": "RegExp", "value": 38.22314685314689}, {"lowerIsBetter": false, "replicates": [530.7855626326964], "unit": "score", "name": "Splay", "value": 153.529044}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 23266.218664201413}]} 03:42:27 INFO - RETURN: dromaeo_css: 7392.15 03:42:27 INFO - RETURN: kraken: 1499.20 03:42:27 INFO - RETURN: v8_7: 23266.22 03:42:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23266.22"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1499.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7392.15"}}} 03:42:27 INFO - Return code: 0 03:42:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:42:27 INFO - # TBPL SUCCESS # 03:42:27 INFO - Running post-action listener: _resource_record_post_action 03:42:27 INFO - Running post-run listener: _resource_record_post_run 03:42:28 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 884736; Write bytes: 277671936; Read time: 232; Write time: 159420 03:42:28 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 14241792; Read time: 0; Write time: 3344 03:42:28 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 884736; Write bytes: 263430144; Read time: 232; Write time: 156076 03:42:28 INFO - Running post-run listener: _upload_blobber_files 03:42:28 INFO - Blob upload gear active. 03:42:28 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:42:28 INFO - Copying logs to upload dir... 03:42:28 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1262.364743 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-12-28 03:42:28.623798) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-28 03:42:28.627476) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009992 build_url: 'https://queue.taskcluster.net/v1/task/u8gIrwl1QrSv-0nrjHRtwQ/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-28 03:42:28.678199) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 03:42:28.678559) ========= 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=5400c60ebd4f8d7cf28c0934000001b8-1451300206.884309-1583860237 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004626 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-28 03:42:28.728084) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 03:42:28.728429) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-28 03:42:28.728738) ========= ========= Total master_lag: 0.24 =========