builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1451042544.67 results: success (0) buildid: 20151225004009 builduid: 13d4201695684cfa9dc36a7711a6ec43 revision: 7b49ae23866ac77a491f2e5e6c3e4e5c97345197 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:24.675114) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:24.675628) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:24.676241) ========= 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=e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006317 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:24.731959) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:24.732279) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:24.812869) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:24.813212) ========= 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=e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004573 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:24.885133) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:24.885418) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:24.885794) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:24.886378) ========= 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=e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-25 03:22:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 54.5M=0s 2015-12-25 03:22:26 (54.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.168506 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:25.069441) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:25.069856) ========= 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=e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016195 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:25.121172) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:25.121497) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 7b49ae23866ac77a491f2e5e6c3e4e5c97345197 --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 7b49ae23866ac77a491f2e5e6c3e4e5c97345197 --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=e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-25 03:22:27,023 truncating revision to first 12 chars 2015-12-25 03:22:27,023 Setting DEBUG logging. 2015-12-25 03:22:27,023 attempt 1/10 2015-12-25 03:22:27,024 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/7b49ae23866a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-25 03:22:27,354 unpacking tar archive at: mozilla-aurora-7b49ae23866a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.621027 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:25.757050) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:25.757557) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:25.779293) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:25.779681) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-25 03:22:25.780193) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-25 03:22:25.780528) ========= /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=e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:22:27 INFO - MultiFileLogger online at 20151225 03:22:27 in /builds/slave/test-pgo 03:22:27 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:22:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:22:27 INFO - {'append_to_log': False, 03:22:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:22:27 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:22:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:22:27 INFO - 'branch': 'Mozilla-Aurora', 03:22:27 INFO - 'buildbot_json_path': 'buildprops.json', 03:22:27 INFO - 'config_files': ('talos/linux_config.py',), 03:22:27 INFO - 'default_actions': ('clobber', 03:22:27 INFO - 'read-buildbot-config', 03:22:27 INFO - 'download-and-extract', 03:22:27 INFO - 'populate-webroot', 03:22:27 INFO - 'create-virtualenv', 03:22:27 INFO - 'install', 03:22:27 INFO - 'run-tests'), 03:22:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:22:27 INFO - 'download_minidump_stackwalk': True, 03:22:27 INFO - 'download_symbols': 'ondemand', 03:22:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:22:27 INFO - 'tooltool.py': '/tools/tooltool.py', 03:22:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:22:27 INFO - '/tools/misc-python/virtualenv.py')}, 03:22:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:22:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:22:27 INFO - 'installer_path': 'installer.exe', 03:22:27 INFO - 'log_level': 'info', 03:22:27 INFO - 'log_name': 'talos', 03:22:27 INFO - 'log_to_console': True, 03:22:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:22:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:22:27 INFO - 'opt_config_files': (), 03:22:27 INFO - 'pip_index': False, 03:22:27 INFO - 'sps_profile': False, 03:22:27 INFO - 'sps_profile_interval': 0, 03:22:27 INFO - 'suite': 'dromaeojs-e10s', 03:22:27 INFO - 'system_bits': '64', 03:22:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:22:27 INFO - 'title': 'talos-linux64-ix-023', 03:22:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:22:27 INFO - 'use_talos_json': True, 03:22:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:22:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:22:27 INFO - 'work_dir': 'build'} 03:22:27 INFO - ##### 03:22:27 INFO - ##### Running clobber step. 03:22:27 INFO - ##### 03:22:27 INFO - Running pre-action listener: _resource_record_pre_action 03:22:27 INFO - Running main action method: clobber 03:22:27 INFO - rmtree: /builds/slave/test-pgo/build 03:22:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:22:28 INFO - Running post-action listener: _resource_record_post_action 03:22:28 INFO - ##### 03:22:28 INFO - ##### Running read-buildbot-config step. 03:22:28 INFO - ##### 03:22:28 INFO - Running pre-action listener: _resource_record_pre_action 03:22:28 INFO - Running main action method: read_buildbot_config 03:22:28 INFO - Using buildbot properties: 03:22:28 INFO - { 03:22:28 INFO - "properties": { 03:22:28 INFO - "buildnumber": 48, 03:22:28 INFO - "product": "firefox", 03:22:28 INFO - "script_repo_revision": "production", 03:22:28 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:22:28 INFO - "repository": "", 03:22:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:22:28 INFO - "buildid": "20151225004009", 03:22:28 INFO - "slavename": "talos-linux64-ix-023", 03:22:28 INFO - "stage_platform": "linux64-pgo", 03:22:28 INFO - "basedir": "/builds/slave/test-pgo", 03:22:28 INFO - "nightly_build": "True", 03:22:28 INFO - "project": "", 03:22:28 INFO - "platform": "ubuntu64_hw", 03:22:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:22:28 INFO - "slavebuilddir": "test", 03:22:28 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:22:28 INFO - "branch": "mozilla-aurora", 03:22:28 INFO - "repo_path": "releases/mozilla-aurora", 03:22:28 INFO - "pgo_build": "True", 03:22:28 INFO - "builduid": "13d4201695684cfa9dc36a7711a6ec43", 03:22:28 INFO - "revision": "7b49ae23866ac77a491f2e5e6c3e4e5c97345197" 03:22:28 INFO - }, 03:22:28 INFO - "sourcestamp": { 03:22:28 INFO - "repository": "", 03:22:28 INFO - "hasPatch": false, 03:22:28 INFO - "project": "", 03:22:28 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:22:28 INFO - "changes": [ 03:22:28 INFO - { 03:22:28 INFO - "category": null, 03:22:28 INFO - "files": [ 03:22:28 INFO - { 03:22:28 INFO - "url": null, 03:22:28 INFO - "name": "https://queue.taskcluster.net/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 03:22:28 INFO - } 03:22:28 INFO - ], 03:22:28 INFO - "repository": "", 03:22:28 INFO - "rev": "7b49ae23866ac77a491f2e5e6c3e4e5c97345197", 03:22:28 INFO - "who": "sendchange", 03:22:28 INFO - "when": 1451042526, 03:22:28 INFO - "number": 7394410, 03:22:28 INFO - "comments": "", 03:22:28 INFO - "project": "", 03:22:28 INFO - "at": "Fri 25 Dec 2015 03:22:06", 03:22:28 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:22:28 INFO - "revlink": "", 03:22:28 INFO - "properties": [ 03:22:28 INFO - [ 03:22:28 INFO - "buildid", 03:22:28 INFO - "20151225004009", 03:22:28 INFO - "Change" 03:22:28 INFO - ], 03:22:28 INFO - [ 03:22:28 INFO - "builduid", 03:22:28 INFO - "13d4201695684cfa9dc36a7711a6ec43", 03:22:28 INFO - "Change" 03:22:28 INFO - ], 03:22:28 INFO - [ 03:22:28 INFO - "nightly_build", 03:22:28 INFO - "True", 03:22:28 INFO - "Change" 03:22:28 INFO - ], 03:22:28 INFO - [ 03:22:28 INFO - "pgo_build", 03:22:28 INFO - "True", 03:22:28 INFO - "Change" 03:22:28 INFO - ] 03:22:28 INFO - ], 03:22:28 INFO - "revision": "7b49ae23866ac77a491f2e5e6c3e4e5c97345197" 03:22:28 INFO - } 03:22:28 INFO - ], 03:22:28 INFO - "revision": "7b49ae23866ac77a491f2e5e6c3e4e5c97345197" 03:22:28 INFO - } 03:22:28 INFO - } 03:22:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 03:22:28 INFO - Running post-action listener: _resource_record_post_action 03:22:28 INFO - ##### 03:22:28 INFO - ##### Running download-and-extract step. 03:22:28 INFO - ##### 03:22:28 INFO - Running pre-action listener: _resource_record_pre_action 03:22:28 INFO - Running main action method: download_and_extract 03:22:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:22:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:28 INFO - https://queue.taskcluster.net/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:22:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/test_packages.json 03:22:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/test_packages.json 03:22:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:22:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:22:34 INFO - Downloaded 1302 bytes. 03:22:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:22:34 INFO - Using the following test package requirements: 03:22:34 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:22:34 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:22:34 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:34 INFO - u'jsshell-linux-x86_64.zip'], 03:22:34 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:22:34 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:22:34 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:22:34 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:22:34 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:22:34 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:22:34 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:22:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:22:34 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:22:34 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:34 INFO - https://queue.taskcluster.net/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:22:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:22:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:22:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/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:22:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/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:22:39 INFO - Downloaded 23022946 bytes. 03:22:39 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:22:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:22:39 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:22:40 INFO - Return code: 0 03:22:40 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:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:40 INFO - https://queue.taskcluster.net/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:22:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:22:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:22:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/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:22:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/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:22:41 INFO - Downloaded 23022946 bytes. 03:22:41 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:22:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:22:41 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:22:42 INFO - Return code: 0 03:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:42 INFO - https://queue.taskcluster.net/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:22:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:22:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:22:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/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:22:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/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:22:43 INFO - Downloaded 11132038 bytes. 03:22:43 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:22:43 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:22:43 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:22:44 INFO - Return code: 0 03:22:44 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:44 INFO - https://queue.taskcluster.net/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:22:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:22:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:22:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/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:22:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NG1CtesbRJeMIi3bWvEdhw/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:22:47 INFO - Downloaded 58072940 bytes. 03:22:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:22:47 INFO - mkdir: /builds/slave/test-pgo/properties 03:22:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:22:47 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:22:47 INFO - Contents: 03:22:47 INFO - build_url:https://queue.taskcluster.net/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:22:47 INFO - Running post-action listener: _resource_record_post_action 03:22:47 INFO - Running post-action listener: set_extra_try_arguments 03:22:47 INFO - ##### 03:22:47 INFO - ##### Running populate-webroot step. 03:22:47 INFO - ##### 03:22:47 INFO - Running pre-action listener: _resource_record_pre_action 03:22:47 INFO - Running main action method: populate_webroot 03:22:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:22:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:22:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:22:47 INFO - '--tppagecycles', 03:22:47 INFO - '7'], 03:22:47 INFO - 'tests': ['tsvgm']}}, 03:22:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:22:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:22:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:22:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:22:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:47 INFO - 'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:22:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:47 INFO - 'tests': ['damp', 'tps']}, 03:22:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:47 INFO - 'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['damp', 'tps']}, 03:22:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:22:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:22:47 INFO - 'other': {'tests': ['a11yr', 03:22:47 INFO - 'ts_paint', 03:22:47 INFO - 'tpaint', 03:22:47 INFO - 'sessionrestore', 03:22:47 INFO - 'sessionrestore_no_auto_restore']}, 03:22:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['a11yr', 03:22:47 INFO - 'ts_paint', 03:22:47 INFO - 'tpaint', 03:22:47 INFO - 'sessionrestore', 03:22:47 INFO - 'sessionrestore_no_auto_restore']}, 03:22:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['a11yr', 03:22:47 INFO - 'ts_paint', 03:22:47 INFO - 'tpaint', 03:22:47 INFO - 'sessionrestore', 03:22:47 INFO - 'sessionrestore_no_auto_restore']}, 03:22:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['a11yr', 03:22:47 INFO - 'ts_paint', 03:22:47 INFO - 'tpaint', 03:22:47 INFO - 'sessionrestore', 03:22:47 INFO - 'sessionrestore_no_auto_restore']}, 03:22:47 INFO - 'other_l64': {'tests': ['a11yr', 03:22:47 INFO - 'ts_paint', 03:22:47 INFO - 'tpaint', 03:22:47 INFO - 'sessionrestore', 03:22:47 INFO - 'sessionrestore_no_auto_restore']}, 03:22:47 INFO - 'other_nol64': {'tests': ['a11yr', 03:22:47 INFO - 'ts_paint', 03:22:47 INFO - 'tpaint', 03:22:47 INFO - 'sessionrestore', 03:22:47 INFO - 'sessionrestore_no_auto_restore']}, 03:22:47 INFO - 'svgr': {'tests': ['tsvgx', 03:22:47 INFO - 'tsvgr_opacity', 03:22:47 INFO - 'tart', 03:22:47 INFO - 'tscrollx', 03:22:47 INFO - 'cart']}, 03:22:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['tsvgx', 03:22:47 INFO - 'tsvgr_opacity', 03:22:47 INFO - 'tart', 03:22:47 INFO - 'tscrollx', 03:22:47 INFO - 'cart']}, 03:22:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:47 INFO - 'tests': ['tp5o']}, 03:22:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:47 INFO - 'talos_options': ['--e10s'], 03:22:47 INFO - 'tests': ['tp5o']}, 03:22:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:47 INFO - 'talos_options': ['--xperf_path', 03:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:47 INFO - 'tests': ['tp5n']}, 03:22:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:22:47 INFO - 'talos_options': ['--e10s', 03:22:47 INFO - '--xperf_path', 03:22:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:22:47 INFO - 'tests': ['tp5n']}}, 03:22:47 INFO - 'talos.zip': {'path': '', 03:22:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:22:47 INFO - Running post-action listener: _resource_record_post_action 03:22:47 INFO - ##### 03:22:47 INFO - ##### Running create-virtualenv step. 03:22:47 INFO - ##### 03:22:47 INFO - Running pre-action listener: _resource_record_pre_action 03:22:47 INFO - Running main action method: create_virtualenv 03:22:47 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:22:47 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:22:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:22:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:22:47 INFO - Using real prefix '/usr' 03:22:47 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:22:47 INFO - Installing distribute.............................................................................................................................................................................................done. 03:22:49 INFO - Installing pip.................done. 03:22:49 INFO - Return code: 0 03:22:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:22: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:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc50a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2487a50>, '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 0x23f3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f39e0>, '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': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', '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: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 03:22: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 pip>=1.5 03:22:49 INFO - Using env: {'DISPLAY': ':0', 03:22:49 INFO - 'HOME': '/home/cltbld', 03:22:49 INFO - 'LANG': 'en_US.UTF-8', 03:22:49 INFO - 'LANGUAGE': 'en_US:en', 03:22:49 INFO - 'LOGNAME': 'cltbld', 03:22:49 INFO - 'MAIL': '/var/mail/cltbld', 03:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:49 INFO - 'MOZ_NO_REMOTE': '1', 03:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:49 INFO - 'NO_EM_RESTART': '1', 03:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:22:49 INFO - 'PWD': '/builds/slave/test-pgo', 03:22:49 INFO - 'SHELL': '/bin/bash', 03:22:49 INFO - 'SHLVL': '1', 03:22:49 INFO - 'TERM': 'linux', 03:22:49 INFO - 'TMOUT': '86400', 03:22:49 INFO - 'USER': 'cltbld', 03:22:49 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', 03:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:49 INFO - '_': '/tools/buildbot/bin/python'} 03:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:50 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:22:50 INFO - Cleaning up... 03:22:50 INFO - Return code: 0 03:22:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:50 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc50a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2487a50>, '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 0x23f3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f39e0>, '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': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', '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:50 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:22:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:22:50 INFO - Using env: {'DISPLAY': ':0', 03:22:50 INFO - 'HOME': '/home/cltbld', 03:22:50 INFO - 'LANG': 'en_US.UTF-8', 03:22:50 INFO - 'LANGUAGE': 'en_US:en', 03:22:50 INFO - 'LOGNAME': 'cltbld', 03:22:50 INFO - 'MAIL': '/var/mail/cltbld', 03:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:50 INFO - 'MOZ_NO_REMOTE': '1', 03:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:50 INFO - 'NO_EM_RESTART': '1', 03:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:22:50 INFO - 'PWD': '/builds/slave/test-pgo', 03:22:50 INFO - 'SHELL': '/bin/bash', 03:22:50 INFO - 'SHLVL': '1', 03:22:50 INFO - 'TERM': 'linux', 03:22:50 INFO - 'TMOUT': '86400', 03:22:50 INFO - 'USER': 'cltbld', 03:22:50 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', 03:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:50 INFO - '_': '/tools/buildbot/bin/python'} 03:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:50 INFO - Downloading/unpacking psutil>=0.7.1 03:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:51 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 03:22:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:22:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:52 INFO - Installing collected packages: psutil 03:22:52 INFO - Running setup.py install for psutil 03:22:52 INFO - building 'psutil._psutil_linux' extension 03:22:52 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:22:52 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:22:52 INFO - building 'psutil._psutil_posix' extension 03:22:52 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:22:52 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:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:22:52 INFO - Successfully installed psutil 03:22:52 INFO - Cleaning up... 03:22:52 INFO - Return code: 0 03:22:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:22: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:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22: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:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc50a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2487a50>, '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 0x23f3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f39e0>, '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': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', '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:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:22:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:22:52 INFO - Using env: {'DISPLAY': ':0', 03:22:52 INFO - 'HOME': '/home/cltbld', 03:22:52 INFO - 'LANG': 'en_US.UTF-8', 03:22:52 INFO - 'LANGUAGE': 'en_US:en', 03:22:52 INFO - 'LOGNAME': 'cltbld', 03:22:52 INFO - 'MAIL': '/var/mail/cltbld', 03:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:52 INFO - 'MOZ_NO_REMOTE': '1', 03:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:52 INFO - 'NO_EM_RESTART': '1', 03:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:22:52 INFO - 'PWD': '/builds/slave/test-pgo', 03:22:52 INFO - 'SHELL': '/bin/bash', 03:22:52 INFO - 'SHLVL': '1', 03:22:52 INFO - 'TERM': 'linux', 03:22:52 INFO - 'TMOUT': '86400', 03:22:52 INFO - 'USER': 'cltbld', 03:22:52 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', 03:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:52 INFO - '_': '/tools/buildbot/bin/python'} 03:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:22:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:22:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:22:54 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:22:54 INFO - Installing collected packages: mozsystemmonitor 03:22:54 INFO - Running setup.py install for mozsystemmonitor 03:22:54 INFO - Successfully installed mozsystemmonitor 03:22:54 INFO - Cleaning up... 03:22:54 INFO - Return code: 0 03:22:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc50a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2487a50>, '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 0x23f3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f39e0>, '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': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', '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:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:22:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:22:54 INFO - Using env: {'DISPLAY': ':0', 03:22:54 INFO - 'HOME': '/home/cltbld', 03:22:54 INFO - 'LANG': 'en_US.UTF-8', 03:22:54 INFO - 'LANGUAGE': 'en_US:en', 03:22:54 INFO - 'LOGNAME': 'cltbld', 03:22:54 INFO - 'MAIL': '/var/mail/cltbld', 03:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:54 INFO - 'MOZ_NO_REMOTE': '1', 03:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:54 INFO - 'NO_EM_RESTART': '1', 03:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:22:54 INFO - 'PWD': '/builds/slave/test-pgo', 03:22:54 INFO - 'SHELL': '/bin/bash', 03:22:54 INFO - 'SHLVL': '1', 03:22:54 INFO - 'TERM': 'linux', 03:22:54 INFO - 'TMOUT': '86400', 03:22:54 INFO - 'USER': 'cltbld', 03:22:54 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', 03:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:54 INFO - '_': '/tools/buildbot/bin/python'} 03:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:54 INFO - Downloading/unpacking blobuploader==1.2.4 03:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:22:56 INFO - Downloading blobuploader-1.2.4.tar.gz 03:22:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:22:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:22:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:22:56 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:56 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:56 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:56 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:56 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:56 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:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:22:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:22:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:22: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:22: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:22: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:22: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:22: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:22: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:22:57 INFO - Downloading docopt-0.6.1.tar.gz 03:22:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:22:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:22:57 INFO - Installing collected packages: blobuploader, requests, docopt 03:22:57 INFO - Running setup.py install for blobuploader 03:22:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:22:57 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:22:57 INFO - Running setup.py install for requests 03:22:57 INFO - Running setup.py install for docopt 03:22:57 INFO - Successfully installed blobuploader requests docopt 03:22:57 INFO - Cleaning up... 03:22:57 INFO - Return code: 0 03:22:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:22:57 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 0x7fc50a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2487a50>, '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 0x23f3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f39e0>, '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': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', '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:57 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:22:57 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:22:57 INFO - Using env: {'DISPLAY': ':0', 03:22:57 INFO - 'HOME': '/home/cltbld', 03:22:57 INFO - 'LANG': 'en_US.UTF-8', 03:22:57 INFO - 'LANGUAGE': 'en_US:en', 03:22:57 INFO - 'LOGNAME': 'cltbld', 03:22:57 INFO - 'MAIL': '/var/mail/cltbld', 03:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:22:57 INFO - 'MOZ_NO_REMOTE': '1', 03:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:22:57 INFO - 'NO_EM_RESTART': '1', 03:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:22:57 INFO - 'PWD': '/builds/slave/test-pgo', 03:22:57 INFO - 'SHELL': '/bin/bash', 03:22:57 INFO - 'SHLVL': '1', 03:22:57 INFO - 'TERM': 'linux', 03:22:57 INFO - 'TMOUT': '86400', 03:22:57 INFO - 'USER': 'cltbld', 03:22:57 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', 03:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:22:57 INFO - '_': '/tools/buildbot/bin/python'} 03:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:22:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:22:58 INFO - Running setup.py (path:/tmp/pip-2MEtEU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:22:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:22:58 INFO - Running setup.py (path:/tmp/pip-FkpK9H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:22:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:22:58 INFO - Running setup.py (path:/tmp/pip-08fK76-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:22:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:22:58 INFO - Running setup.py (path:/tmp/pip-UWpGC3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:22:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:22:58 INFO - Running setup.py (path:/tmp/pip-C2zVFJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:22:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:22:58 INFO - Running setup.py (path:/tmp/pip-h5Jhm7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:22:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:22:58 INFO - Running setup.py (path:/tmp/pip-pOSqPo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:22:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:22:58 INFO - Running setup.py (path:/tmp/pip-E3iNep-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:22:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:22:58 INFO - Running setup.py (path:/tmp/pip-ALhOp5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:22:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:22:58 INFO - Running setup.py (path:/tmp/pip-2y47I8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:22:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:22:58 INFO - Running setup.py (path:/tmp/pip-m40KcG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:22:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:22:58 INFO - Running setup.py (path:/tmp/pip-Gs8XYA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:22:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:22:58 INFO - Running setup.py (path:/tmp/pip-kOYlND-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:22:59 INFO - Running setup.py (path:/tmp/pip-bb1Vup-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:22:59 INFO - Running setup.py (path:/tmp/pip-livK7F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:22:59 INFO - Running setup.py (path:/tmp/pip-0cKO8r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:22:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:22:59 INFO - Running setup.py (path:/tmp/pip-DW4Oyh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:22:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:22:59 INFO - Running setup.py install for manifestparser 03:22:59 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:22:59 INFO - Running setup.py install for mozcrash 03:22:59 INFO - Running setup.py install for mozdebug 03:22:59 INFO - Running setup.py install for mozdevice 03:22:59 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:22:59 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:22:59 INFO - Running setup.py install for mozfile 03:22:59 INFO - Running setup.py install for mozhttpd 03:22:59 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:22:59 INFO - Running setup.py install for mozinfo 03:23:00 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:23:00 INFO - Running setup.py install for mozInstall 03:23:00 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:23:00 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:23:00 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:23:00 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:23:00 INFO - Running setup.py install for mozleak 03:23:00 INFO - Running setup.py install for mozlog 03:23:00 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:23:00 INFO - Running setup.py install for moznetwork 03:23:00 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:23:00 INFO - Running setup.py install for mozprocess 03:23:00 INFO - Running setup.py install for mozprofile 03:23:00 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:23:00 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:23:00 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:23:00 INFO - Running setup.py install for mozrunner 03:23:00 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:23:00 INFO - Running setup.py install for mozscreenshot 03:23:00 INFO - Running setup.py install for moztest 03:23:00 INFO - Running setup.py install for mozversion 03:23:01 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:23:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:23:01 INFO - Cleaning up... 03:23:01 INFO - Return code: 0 03:23:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:23: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:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23: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', '-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 0x7fc50a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2487a50>, '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 0x23f3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f39e0>, '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': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', '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:23:01 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:23:01 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:23:01 INFO - Using env: {'DISPLAY': ':0', 03:23:01 INFO - 'HOME': '/home/cltbld', 03:23:01 INFO - 'LANG': 'en_US.UTF-8', 03:23:01 INFO - 'LANGUAGE': 'en_US:en', 03:23:01 INFO - 'LOGNAME': 'cltbld', 03:23:01 INFO - 'MAIL': '/var/mail/cltbld', 03:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:01 INFO - 'MOZ_NO_REMOTE': '1', 03:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:01 INFO - 'NO_EM_RESTART': '1', 03:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:23:01 INFO - 'PWD': '/builds/slave/test-pgo', 03:23:01 INFO - 'SHELL': '/bin/bash', 03:23:01 INFO - 'SHLVL': '1', 03:23:01 INFO - 'TERM': 'linux', 03:23:01 INFO - 'TMOUT': '86400', 03:23:01 INFO - 'USER': 'cltbld', 03:23:01 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', 03:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:01 INFO - '_': '/tools/buildbot/bin/python'} 03:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:23:01 INFO - Running setup.py (path:/tmp/pip-bNiuol-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:23:01 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:23:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:23:01 INFO - Running setup.py (path:/tmp/pip-NilVE0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:23:01 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:23:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:23:01 INFO - Running setup.py (path:/tmp/pip-lJcslU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:23:01 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:23:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:23:01 INFO - Running setup.py (path:/tmp/pip-vp_hrW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:23:01 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:23:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:23:01 INFO - Running setup.py (path:/tmp/pip-hxpI3v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:23:01 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:23:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:23:01 INFO - Running setup.py (path:/tmp/pip-nO43z0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:23:01 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:23:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:23:01 INFO - Running setup.py (path:/tmp/pip-Ic06RF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:23:01 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:23:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:23:01 INFO - Running setup.py (path:/tmp/pip-pZuJ4Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:23:01 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:23:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:23:01 INFO - Running setup.py (path:/tmp/pip-iKo1HE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:23:01 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:23:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:23:01 INFO - Running setup.py (path:/tmp/pip-bQx12a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:23:02 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:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:23:02 INFO - Running setup.py (path:/tmp/pip-5YOEa2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:23:02 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:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:23:02 INFO - Running setup.py (path:/tmp/pip-z0P8ny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:23:02 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:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:23:02 INFO - Running setup.py (path:/tmp/pip-A3Eitm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:23:02 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:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:23:02 INFO - Running setup.py (path:/tmp/pip-XcPOgj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:23:02 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:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:23:02 INFO - Running setup.py (path:/tmp/pip-hAdnvE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:23:02 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:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:23:02 INFO - Running setup.py (path:/tmp/pip-29uxiy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:23:02 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:23:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:23:02 INFO - Running setup.py (path:/tmp/pip-_SZr2Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:23:02 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:23:02 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:23:02 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:23:02 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:23:02 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:23:02 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:23:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:23:02 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:23:02 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:23:02 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:23:02 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:23:02 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:23:02 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:23:04 INFO - Downloading blessings-1.5.1.tar.gz 03:23:04 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:23:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:23:04 INFO - Installing collected packages: blessings 03:23:04 INFO - Running setup.py install for blessings 03:23:04 INFO - Successfully installed blessings 03:23:04 INFO - Cleaning up... 03:23:04 INFO - Return code: 0 03:23:04 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:23:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:23:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:23:04 INFO - Reading from file tmpfile_stdout 03:23:04 INFO - Current package versions: 03:23:04 INFO - argparse == 1.2.1 03:23:04 INFO - blessings == 1.5.1 03:23:04 INFO - blobuploader == 1.2.4 03:23:04 INFO - docopt == 0.6.1 03:23:04 INFO - manifestparser == 1.1 03:23:04 INFO - mozInstall == 1.12 03:23:04 INFO - mozcrash == 0.16 03:23:04 INFO - mozdebug == 0.1 03:23:04 INFO - mozdevice == 0.47 03:23:04 INFO - mozfile == 1.2 03:23:04 INFO - mozhttpd == 0.7 03:23:04 INFO - mozinfo == 0.9 03:23:04 INFO - mozleak == 0.1 03:23:04 INFO - mozlog == 3.1 03:23:04 INFO - moznetwork == 0.27 03:23:04 INFO - mozprocess == 0.22 03:23:04 INFO - mozprofile == 0.27 03:23:04 INFO - mozrunner == 6.11 03:23:04 INFO - mozscreenshot == 0.1 03:23:04 INFO - mozsystemmonitor == 0.0 03:23:04 INFO - moztest == 0.7 03:23:04 INFO - mozversion == 1.4 03:23:04 INFO - psutil == 3.1.1 03:23:04 INFO - requests == 1.2.3 03:23:04 INFO - wsgiref == 0.1.2 03:23:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:23:04 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:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:04 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:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:04 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 0x7fc50a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2487a50>, '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 0x23f3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f39e0>, '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': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', '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:23:04 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:23:04 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:23:04 INFO - Using env: {'DISPLAY': ':0', 03:23:04 INFO - 'HOME': '/home/cltbld', 03:23:04 INFO - 'LANG': 'en_US.UTF-8', 03:23:04 INFO - 'LANGUAGE': 'en_US:en', 03:23:04 INFO - 'LOGNAME': 'cltbld', 03:23:04 INFO - 'MAIL': '/var/mail/cltbld', 03:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:04 INFO - 'MOZ_NO_REMOTE': '1', 03:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:04 INFO - 'NO_EM_RESTART': '1', 03:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:23:04 INFO - 'PWD': '/builds/slave/test-pgo', 03:23:04 INFO - 'SHELL': '/bin/bash', 03:23:04 INFO - 'SHLVL': '1', 03:23:04 INFO - 'TERM': 'linux', 03:23:04 INFO - 'TMOUT': '86400', 03:23:04 INFO - 'USER': 'cltbld', 03:23:04 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', 03:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:04 INFO - '_': '/tools/buildbot/bin/python'} 03:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:04 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:23:04 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:23:04 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:23:04 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:23:04 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:23:04 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:23:04 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:23:04 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:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 03:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 03:23:04 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:23:04 INFO - Cleaning up... 03:23:04 INFO - Return code: 0 03:23:04 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:23:04 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:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:04 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:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:04 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 0x7fc50a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2487a50>, '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 0x23f3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f39e0>, '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': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', '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:23:04 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:23:04 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:23:04 INFO - Using env: {'DISPLAY': ':0', 03:23:04 INFO - 'HOME': '/home/cltbld', 03:23:04 INFO - 'LANG': 'en_US.UTF-8', 03:23:04 INFO - 'LANGUAGE': 'en_US:en', 03:23:04 INFO - 'LOGNAME': 'cltbld', 03:23:04 INFO - 'MAIL': '/var/mail/cltbld', 03:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:04 INFO - 'MOZ_NO_REMOTE': '1', 03:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:04 INFO - 'NO_EM_RESTART': '1', 03:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:23:04 INFO - 'PWD': '/builds/slave/test-pgo', 03:23:04 INFO - 'SHELL': '/bin/bash', 03:23:04 INFO - 'SHLVL': '1', 03:23:04 INFO - 'TERM': 'linux', 03:23:04 INFO - 'TMOUT': '86400', 03:23:04 INFO - 'USER': 'cltbld', 03:23:04 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', 03:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:04 INFO - '_': '/tools/buildbot/bin/python'} 03:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:05 INFO - Downloading/unpacking jsonschema 03:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:23:06 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:23:06 INFO - Downloading/unpacking functools32 (from jsonschema) 03:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:06 INFO - Downloading functools32-3.2.3-2.tar.gz 03:23:06 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:23:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:23:07 INFO - warning: no files found matching '*.txt' 03:23:07 INFO - no previously-included directories found matching 'build' 03:23:07 INFO - no previously-included directories found matching 'dist' 03:23:07 INFO - no previously-included directories found matching '.git*' 03:23:07 INFO - Installing collected packages: jsonschema, functools32 03:23:07 INFO - Running setup.py install for functools32 03:23:07 INFO - warning: no files found matching '*.txt' 03:23:07 INFO - no previously-included directories found matching 'build' 03:23:07 INFO - no previously-included directories found matching 'dist' 03:23:07 INFO - no previously-included directories found matching '.git*' 03:23:07 INFO - Successfully installed jsonschema functools32 03:23:07 INFO - Cleaning up... 03:23:07 INFO - Return code: 0 03:23:07 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:23:07 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc50a179f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23278a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23f5450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2487a50>, '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 0x23f3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f39e0>, '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': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', '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:23:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 03:23:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:23:07 INFO - Using env: {'DISPLAY': ':0', 03:23:07 INFO - 'HOME': '/home/cltbld', 03:23:07 INFO - 'LANG': 'en_US.UTF-8', 03:23:07 INFO - 'LANGUAGE': 'en_US:en', 03:23:07 INFO - 'LOGNAME': 'cltbld', 03:23:07 INFO - 'MAIL': '/var/mail/cltbld', 03:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:07 INFO - 'MOZ_NO_REMOTE': '1', 03:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:07 INFO - 'NO_EM_RESTART': '1', 03:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:23:07 INFO - 'PWD': '/builds/slave/test-pgo', 03:23:07 INFO - 'SHELL': '/bin/bash', 03:23:07 INFO - 'SHLVL': '1', 03:23:07 INFO - 'TERM': 'linux', 03:23:07 INFO - 'TMOUT': '86400', 03:23:07 INFO - 'USER': 'cltbld', 03:23:07 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', 03:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:07 INFO - '_': '/tools/buildbot/bin/python'} 03:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:23:07 INFO - Downloading/unpacking flake8 03:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:23:09 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:23:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:23:09 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:23:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:09 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:23:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:23:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:23:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:23:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:23:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:23:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:23:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:23:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:23:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:23:09 INFO - no previously-included directories found matching 'docs/_build' 03:23:09 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:23:09 INFO - Running setup.py install for pep8 03:23:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:23:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:23:09 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:23:09 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:23:09 INFO - no previously-included directories found matching 'docs/_build' 03:23:09 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:23:09 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:23:09 INFO - Cleaning up... 03:23:10 INFO - Return code: 0 03:23:10 INFO - Running post-action listener: _resource_record_post_action 03:23:10 INFO - Running post-action listener: _start_resource_monitoring 03:23:10 INFO - Starting resource monitoring. 03:23:10 INFO - ##### 03:23:10 INFO - ##### Running install step. 03:23:10 INFO - ##### 03:23:10 INFO - Running pre-action listener: _resource_record_pre_action 03:23:10 INFO - Running main action method: install 03:23:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:23:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:23:10 INFO - Reading from file tmpfile_stdout 03:23:10 INFO - Detecting whether we're running mozinstall >=1.0... 03:23:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:23:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:23:10 INFO - Reading from file tmpfile_stdout 03:23:10 INFO - Output received: 03:23:10 INFO - Usage: mozinstall [options] installer 03:23:10 INFO - Options: 03:23:10 INFO - -h, --help show this help message and exit 03:23:10 INFO - -d DEST, --destination=DEST 03:23:10 INFO - Directory to install application into. [default: 03:23:10 INFO - "/builds/slave/test-pgo"] 03:23:10 INFO - --app=APP Application being installed. [default: firefox] 03:23:10 INFO - mkdir: /builds/slave/test-pgo/build/application 03:23:10 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:23:10 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:23:24 INFO - Reading from file tmpfile_stdout 03:23:24 INFO - Output received: 03:23:24 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:23:24 INFO - Running post-action listener: _resource_record_post_action 03:23:24 INFO - ##### 03:23:24 INFO - ##### Running run-tests step. 03:23:24 INFO - ##### 03:23:24 INFO - Running pre-action listener: _resource_record_pre_action 03:23:24 INFO - Running main action method: run_tests 03:23:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:23:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:23:24 INFO - Python 2.7.3 03:23:24 INFO - Return code: 0 03:23:24 INFO - grabbing minidump binary from tooltool 03:23:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:23:24 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2487a50>, '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 0x23f3550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23f39e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:23:24 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 03:23:24 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:23:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:23:24 INFO - Return code: 0 03:23:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:23:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:23:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:23:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:23:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:23:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:23:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:23:25 INFO - Return code: 0 03:23:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:23:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost 03:23:25 INFO - Using env: {'DISPLAY': ':0', 03:23:25 INFO - 'HOME': '/home/cltbld', 03:23:25 INFO - 'LANG': 'en_US.UTF-8', 03:23:25 INFO - 'LANGUAGE': 'en_US:en', 03:23:25 INFO - 'LOGNAME': 'cltbld', 03:23:25 INFO - 'MAIL': '/var/mail/cltbld', 03:23:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:23:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:23:25 INFO - 'MOZ_NO_REMOTE': '1', 03:23:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:23:25 INFO - 'NO_EM_RESTART': '1', 03:23:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:23:25 INFO - 'PWD': '/builds/slave/test-pgo', 03:23:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:23:25 INFO - 'SHELL': '/bin/bash', 03:23:25 INFO - 'SHLVL': '1', 03:23:25 INFO - 'TERM': 'linux', 03:23:25 INFO - 'TMOUT': '86400', 03:23:25 INFO - 'USER': 'cltbld', 03:23:25 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121', 03:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:23:25 INFO - '_': '/tools/buildbot/bin/python'} 03:23:25 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/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] with output_timeout 3600 03:23:26 INFO - mozversion INFO | application_buildid: 20151225004009 03:23:26 INFO - mozversion INFO | application_changeset: 7b49ae23866ac77a491f2e5e6c3e4e5c97345197 03:23:26 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:23:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:23:26 INFO - mozversion INFO | application_name: Firefox 03:23:26 INFO - mozversion INFO | application_remotingname: firefox-dev 03:23:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:23:26 INFO - mozversion INFO | application_vendor: Mozilla 03:23:26 INFO - mozversion INFO | application_version: 45.0a2 03:23:26 INFO - mozversion INFO | platform_buildid: 20151225004009 03:23:26 INFO - mozversion INFO | platform_changeset: 7b49ae23866ac77a491f2e5e6c3e4e5c97345197 03:23:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:23:26 INFO - mozversion INFO | platform_version: 45.0a2 03:23:26 INFO - 2015-12-25 03:23:26,121 DEBUG : using testdate: 1451042606 03:23:26 INFO - 2015-12-25 03:23:26,121 DEBUG : actual date: 1451042606 03:23:26 INFO - 2015-12-25 03:23:26,173 INFO : starting webserver on 'localhost:59058' 03:23:26 INFO - 2015-12-25 03:23:26,174 INFO : Starting test suite talos-linux64-ix-023.e 03:23:26 INFO - 2015-12-25 03:23:26,174 INFO : Starting test dromaeo_css 03:23:26 INFO - 2015-12-25 03:23:26,174 DEBUG : operating with platform_type : linux_ 03:23:26 INFO - 2015-12-25 03:23:26,175 INFO : Initialising browser for dromaeo_css test... 03:23:26 INFO - 2015-12-25 03:23:26,188 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_EMoyZ/profile http://localhost:59058/getInfo.html 03:23:30 INFO - 2015-12-25 03:23:30,810 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:23:30 INFO - 2015-12-25 03:23:30,811 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:23:30 INFO - 2015-12-25 03:23:30,811 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 03:23:30 INFO - 2015-12-25 03:23:30,811 DEBUG : BROWSER_OUTPUT: __metrics 03:23:31 INFO - 2015-12-25 03:23:31,802 INFO : Browser initialized. 03:23:31 INFO - 2015-12-25 03:23:31,803 INFO : Running cycle 1/1 for dromaeo_css test... 03:23:31 INFO - 2015-12-25 03:23:31,803 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp_EMoyZ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:23:43 INFO - 2015-12-25 03:23:43,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 138825728 03:23:43 INFO - 2015-12-25 03:23:43,650 DEBUG : BROWSER_OUTPUT: 03:24:33 INFO - 2015-12-25 03:24:33,266 DEBUG : BROWSER_OUTPUT: 1451042673259 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:26:41 INFO - 2015-12-25 03:26:41,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59058/tests/dromaeo/cssquery-ext.html) 03:26:42 INFO - 2015-12-25 03:26:42,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 142028800 03:26:42 INFO - 2015-12-25 03:26:42,257 DEBUG : BROWSER_OUTPUT: 03:29:44 INFO - 2015-12-25 03:29:44,112 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/dromaeo/cssquery-ext.html (next: http://localhost:59058/tests/dromaeo/cssquery-jquery.html) 03:29:44 INFO - 2015-12-25 03:29:44,693 DEBUG : BROWSER_OUTPUT: RSS: Main: 140951552 03:29:44 INFO - 2015-12-25 03:29:44,693 DEBUG : BROWSER_OUTPUT: 03:32:46 INFO - 2015-12-25 03:32:46,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59058/tests/dromaeo/cssquery-mootools.html) 03:32:46 INFO - 2015-12-25 03:32:46,877 DEBUG : BROWSER_OUTPUT: RSS: Main: 138350592 03:32:46 INFO - 2015-12-25 03:32:46,877 DEBUG : BROWSER_OUTPUT: 03:35:48 INFO - 2015-12-25 03:35:48,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59058/tests/dromaeo/cssquery-prototype.html) 03:35:49 INFO - 2015-12-25 03:35:49,068 DEBUG : BROWSER_OUTPUT: RSS: Main: 139943936 03:35:49 INFO - 2015-12-25 03:35:49,068 DEBUG : BROWSER_OUTPUT: 03:38:51 INFO - 2015-12-25 03:38:51,304 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59058/tests/dromaeo/cssquery-yui.html) 03:38:51 INFO - 2015-12-25 03:38:51,890 DEBUG : BROWSER_OUTPUT: RSS: Main: 139902976 03:38:51 INFO - 2015-12-25 03:38:51,890 DEBUG : BROWSER_OUTPUT: 03:41:53 INFO - 2015-12-25 03:41:53,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/dromaeo/cssquery-yui.html (next: http://localhost:59058/tests/dromaeo/cssquery-dojo.html) 03:41:54 INFO - 2015-12-25 03:41:54,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 141398016 03:41:54 INFO - 2015-12-25 03:41:54,232 DEBUG : BROWSER_OUTPUT: 03:41:54 INFO - 2015-12-25 03:41:54,232 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:41:54 INFO - 2015-12-25 03:41:54,232 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:41:54 INFO - 2015-12-25 03:41:54,232 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:41:54 INFO - 2015-12-25 03:41:54,232 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:41:54 INFO - 2015-12-25 03:41:54,233 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3347.497875318702;3409.403354412977;3413.7951722896614;3445.9827700861492;3446.069561218472;5633.521150702185;5636.4363563643665;5664.0937450008005;5666.631668941516;5672.744726487308;5565.6104072714925;5660.235868157797;5661.490465858072;5670.5463562914865;5707.343655479621;5125.154349532323;5173;5232.686038837682;5236.2931004314505;5250.501202385767;4981.676191047589;5140.742962851842;5147.48525147486;5151.278820965049;5196.8700782480555;5126.974365128169;5177.32694749682;5189.6886186828915;5207.192885102796;5210.296609957664;5160.509751573594;5189.714565698904;5195.766190521435;5203.115470370046;5239.21411788231;4908.239222920453;4939.777710003059;4982.103221420143;5085.542301192911;5115.565176959963;5480.150576660624;5485.396606373296;5499.202615620713;5520.337559492847;5537.889242215133;6078.057901025348;6129.632222066691;6153.077038444225;6163.013917773134;6183.536234782365;5891.764329426818;5998.880022399571;6126.356732543063;6207.34822843604;6234.251889773211;5602.1036634138345;5618.073017952033;5629.3526244482;5649.2091107244605;5688.004599195125;6202.81391558254;6203.379662033761;6203.596766210182;6205.751769929152;6206.193194884636;5739.741711622987;5781.421857814269;5815.41845815415;5838.94161058384;5843.386444423274;6009.369016253318;6034.456898879122;6039.516838652898;6047.244094488189;6052.092186172022;5967.880642387128;6018.458338749533;6020.397960204032;6028.4272994065495;6030.728617212236;5800.50695690871;5832.475077243069;5854.7072646367515;5983.940160598426;6022.5483088768515;4631.791569379386;4650.395448591661;4654.045920586272;4669.159551280802;4720.976395118002;4194;4210.32634778434;4212.410262563244;4212.978935105305;4226.556211597799;5631.099024156116;5678.375378708339;5735.4551317624755;5791.536677065825;5842.474177324061;6086.269647642312;6150.354212807681;6194.721237544321;6202.224721909762;6203.596766210182;5627.099664053731;5887.028640274392;5890.352061273256;5895.20414744004;5903.498202652737;5211.947880521222;5259.552938000236;5295.205719142083;5343.4389389113585;5369.4362091980565;6160.691965401712;6173.9073913891325;6221.720022598994;6235.376462353728;6242.750289988349;5939.287285525765;6032.095185722177;6080.90878636812;6089.2997305310455;6095.969520152459;6147.877042459037;6258.874822503615;6282.308946016026;6293.37066293367;6317.652529110943;5948.762049517971;5987.34139244674;5988.820335389945;6013.458788708862;6034.487068599218;5953.464188223081;5979.5814292999075;6058.303295121117;6126.693665316628;6151;5960.701964901824;6018.699065046642;6033.698315084316;6043.607165534227;6057.091436284416;5928.170056192223;6002.819915402545;6009.729562169626;6012.579119461596;6012.969935150296;5712.285964254468;5863.912041319299;5885.234919460443;5910.113482977587;5925.644461332334;5937.524998000236;5947.226860508106;6020.397960203944;6061.818145455643;6080.027195648675;5807.970960145172;5882.911756323573;5887.116932460165;5910.734016969161;5916.55625828056 03:41:54 INFO - 2015-12-25 03:41:54,237 DEBUG : BROWSER_OUTPUT: |1;ext.html;597.2832600878945;612.8192183305924;630.6027202862197;633.8859005379036;680.2890978927021;39158.608413915856;39957.400638990366;39978.40032399516;40091.599084009154;40132.197356052864;40850.7957460213;41339;41422;41539.58460415395;41565.168696626046;8890.066543012988;9028.68399606014;9045.140711632384;9049.411788233743;9053.864192037125;8825.161609647073;8899.866502002475;8925.062868398822;8939.910600894005;8965.95517022414;8837.513936733478;8908.910910890905;8944;8953.194212520872;8965.462072275652;8905.777355566099;8917.821643567126;8928.285737141014;8966.686165984192;8967.596458159398;8806.767052612575;8920.420172688819;8921.910780892238;8967.282617390592;8981.865272020925;38242.42636360429;38355.61644383548;38814;38877.22245555101;38949.22101557982;3604.6034936157002;3707.5180226570374;4087.7956102195067;4307.655387568987;4400.6259467945265;31250.687493125006;31748.20629484258;31858.522122168186;31988.360232795214;32052.519212211835;4275.551067137968;4294.484661840599;4332.501762297313;4355.5644435556505;4367.192069467159;281137;285201.9999999979;286104;286839;287484;44547.55452445434;45016;57900.4209957895;58172.418275817545;58189;45940.77029614831;45971;45977.77011114923;46114;46270;14734.705305893822;14791.260436978324;14930.776038359434;14988.325525351385;15154.696906062038;11015.669529914116;11109.44452777358;11119.777604447865;11139.443027848574;11167.441627918572;15518.9224053879;15541.689166216613;15583.220838958006;15611.297491612904;15629.374825006873;5875.588708790344;6056.757729690851;6068.666223357758;6074.179985701874;6149.5080393568405;977.5552123783662;1086.2342048855537;1087.2226358153957;1098.9724607492021;1103.4151899493281;27572.44855102927;27822.721772782013;28177;28266.576001359997;28605.85697071543;1094.0919037199264;1101.5813990683648;1115.938623375722;1121.6803211084803;1137.82932560115;14293.57119286423;14299.85700143006;14383.712325753635;14684.926575367268;14730.337134828958;692805;695902;707554;777032;784731;55992.72003639956;56441.15338269929;56769.43230567641;56896.715516422984;56913.14630280549;1416.2847761880184;1433.7992681024664;1439.4673970630934;1450.144414795276;1461.2474575593578;29848.701512984593;32045.67954320427;32785.34429311448;32831.507527387585;33618.32763344768;52841;52946.47053529415;52992.20511692405;53040;53276.73361633167;329093;329907;330934;332395;332646;42807.3578896323;43345;44652.55347446614;44721.55278447304;44830.77584612056;47747.52252477431;47912.2813157796;47965.5203447975;48126.518734812205;48255;40222.39666405065;40734.185316294104;43512;45134.77432612816;45702.54297457116;37926.02358017056;38311.80844095762;38808.6119138805;38922.6107738919;38935.805320974345;38012.80993595014;38103.2379352417;42638.36042459303;43355;43800.56199437965;32082.83958580192;33669.83165084257;33768.66231337655;34153.31693366069;34344.14139646529;25857;26004.34989125287;26012;26229.606555902057;26394 03:41:54 INFO - 2015-12-25 03:41:54,238 DEBUG : BROWSER_OUTPUT: |2;jquery.html;393.722262167456;396.58952983661914;398.24731257922525;399.57046175361484;400.79759721340736;15843.12862792549;16221.188940552984;17417.564560885985;17793.7330940036;17812.19845106972;11616.186866919319;12364.381780910964;17252.741208881846;18393.080345982682;18520.259189632397;5026.623003274751;5287.418383977779;5288.550473209782;5291.2327712481665;5294.41761406245;5099.490050994889;5219.739013049332;5223.503767142115;5229;5232.032074066291;5146.485351464861;5193.298904647881;5199.220116982445;5203.531682148606;5328.387235467912;5291.86770330741;5319.787208511655;5327.760250788685;5343.118385466393;5358.812441564546;5505.229267902497;5511.145772405243;5517.393086760453;5520.1443776214755;5521.503064724194;12715.109942304043;13209.669758256121;13246.403911823894;13565.118267312593;13726.931365343109;2179.7493288271894;2221.8444708870384;2269.126386341254;2276.089564174327;2316.6061769499224;9908.504574771232;10060.547275372626;12664.4301006454;13142.605721828264;13903.165810051429;1979.4457551885496;2049.897505124738;2050.8872012039333;2123.692064650617;2128.2763860287578;61493.38506614921;66767.66616166936;67255.3274467254;67375;67705.3229467704;10964.342139471657;10966.945165274283;11015.118790496741;11028.117750579935;11080.279781814317;14326.212058336683;14421.20683362404;14452.060616059922;14468.27658617065;14519.709605807824;7880.369570434352;7921.960390198127;7922.920770792333;7928.7224947127725;7969.163237859942;7618.314351708373;7649.655765490566;7680;7706.653200605986;7717.2668596483245;4710.24636058229;4721.1265915805;4737.45519265282;4743.478217396084;4927.334809800703;1910.436421255733;1931.4591914264029;1952.1215453046186;1958.6474434601907;1991.153759652142;883.5758835758871;942.4157022646003;962.7256231973854;972.4505654305295;1044.4516628769957;17268.481945541655;17555.561110972074;17817.287308507774;17824.46526604204;18076.638467230583;982.1995074014656;983.4296108257194;1003.8494225866178;1008.2639673038576;1030.0523518363125;9973.451460169761;10079.69760907174;10150.949245253727;10177.287589868638;10212.131968782736;638901;640549;648382;677198;680193;82875;84081;85549;86142;87707.56146219229;1122.0686829931137;1130.0902773267435;1133.795916734979;1140.4582823158933;1143.5082914346744;15455.459058932884;15758.763618545501;15845.366185352457;15864.76202856935;16118;36440.635593643725;36498.45252321164;37210.06974825651;37784.62215377811;38208.23583528258;49122.75438622784;49170.75414622904;50726;51000.74499627478;51021.48978510316;9971.551280192554;10300.484975751033;10343.120834729132;10388.584456621651;10434.895651043393;17623.559411014827;17944.37194698179;18117;18146.092695364914;18474.538136546693;14316.141031538142;14522.927385363428;14665.26673666291;15264.847351526787;15451.768223476882;11437.59968401102;15454;15482.380704772133;15918.602034948755;16126.193690315671;16115.838841611434;16221.756673650141;16242.025478471329;16595.41916032933;16609.916950415653;9994.750131246778;10383.480825958823;10417.322874013165;10442.791144177227;10566.630167944086;11133.721656958642;12499.687507812378;15923.840761592235;16206;16356.34574617002 03:41:54 INFO - 2015-12-25 03:41:54,240 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1421.6374824419772;1472.4331132513983;1659.145540046876;1835.5044138082726;1845.3817970979712;7290.599017054066;7692.884606730903;7754.728584499537;7764.378849692018;7815.101263354716;7792.376609871211;7869.488483248585;7912.090109637379;7929.088154862193;7945.12603613602;2341.309313752439;2360.8347415680823;2376.7979721723673;2385.2486466763003;2389.378761522008;2319.4549280918973;2373.027058905849;2389.175734371639;2389.665446837444;2389.784919357266;2317.8261630377706;2350.8589484630893;2362.338545207345;2369.6445533170076;2381.880905954704;2315.98096837391;2333.474968132157;2364.148906393697;2396.9880150599224;2401.2796161151587;2342.355852140658;2376.251480783565;2378.120095564635;2378.322178179228;2401.2556107606697;7667.846643067163;7738.226177382273;7756.379489640815;7760.06879174497;7769.339606133485;4651.488336283006;4757.1912774828015;4763.499832517605;4773.832915847964;4776.140294746944;3109.0828205679377;3118.3607360491274;3182.1726351148636;3202.327511222646;3225.709686128236;1105.5798796457295;1113.560143743217;1119.4514687802919;1141.925774824642;1142.1719253541198;10423;10491.999999999924;10492.422916739577;10525.36847789135;10551.261411701184;4112.835486580503;4192.559781222989;4199.517055538591;4203.348480985452;4235.131797981407;8618.482891026433;8643.913560864437;8657.653693852302;8662.090480499583;8674.739757807276;4686.976565117153;4694.929576056362;4716.292556116541;4719.622430205575;4736.265878788793;4324.459442569679;4335.111302183045;4339.088791353851;4340.826366945287;4351;3550.6449355064287;3611.63883611642;3613.0786649404236;3624.1664417184197;3653.5615726112505;1096.71485413793;1099.2085698297212;1105.5577768892508;1118.116687816632;1197.958071467512;998.9550470228858;1019.3628981886321;1033.5504055735778;1215.2222577550199;1432.7564314066633;7262.891056634155;7371.557706537625;7457.440691948017;7470.439717021245;7476.626168691544;1158.7798318319492;1166.084623570493;1178.192937837584;1201.159188568006;1202.663254288783;5872.559558033165;5962.731677074542;5968.253968253968;6017.849553761103;6019.909701354483;9238.538073096319;9240.306976976754;9292.814143717087;9320.8601870972;9383.202427793578;8958.417702849294;9070.820793296829;9227.123423274777;9227.90772092284;9266.953665231631;7295.124585049722;7368.373688236453;7382.0034295370515;7382.889256661155;7389.963050184715;7018.613976231356;7042;7050.189228238613;7074.257202993817;7098.538594991515;8056.879146812919;8108.3513318933165;8192.795180120307;8211.507309561446;8285.964254468192;8282.296004839414;8364.665413383396;8365.038020627706;8373.37199710012;8482.491050536988;6632.336766323329;6663.067170596023;6701.195856497252;6703.597784132968;6712;7427.108746950401;7452.292032256927;7471.6637751302405;7493.812654683677;7522.774316770506;6754.155730533684;6756.358145976124;6837.897431538431;6973.79078627642;7145.642717863982;6731.495137864582;6876.518643694893;6911.723531058701;6941.861162776817;7009;7046.4715146363205;7081.362677358857;7093.680784364613;7106.253843346581;7135.892961605477;6526.086347911391;6564.442022427956;6588;6596.340365963365;6610.570312929644;6453.903191452226;6608.306127856506;6646.202455705346;6674.032265321598;6686.431653309329 03:41:54 INFO - 2015-12-25 03:41:54,243 DEBUG : BROWSER_OUTPUT: |4;prototype.html;361.62571738250915;362.52994108888464;362.66634696079615;364.93978493548565;370.8942951258891;6163.660998645073;6327.841803954903;6344.492440604752;6345;6423.486121110317;6142;6329.272133704625;6329.49364050876;6340.778072767454;6344.777932772354;4842.152623290927;4866.537678920515;4869.756512174395;4894.045661096087;4895.461499235082;4907.460179380265;4911.533404326583;4915.483874193212;4917.041176970492;4919.926201106986;4759.690620109682;4848.563629273364;4851.781669824849;4853.611711063124;4865.172920603506;4838.371011768483;4838.467768545457;4838.516148385133;4840.685355451919;4848.830290939818;4257.8296868125235;4267.850625228102;4268.466441694788;4278.465191851019;4282.293421585435;5911.763529458816;5992.43071908168;5997.580169388145;5998.580099393044;5998.880022399528;5657.745401456944;5660.066089095294;5662.858428539278;5669.659820410789;5670.5463562914865;6698;6708.362705542965;6709.6980635871505;6715.966420167868;6727.788997980361;4736.786844592001;4737.952620473786;4741.383620129361;4744.478107408182;4747.952520474785;6878.174619045746;7023.157221133446;7032.226455089987;7032.789016329467;7045.929540704578;4831.251156070814;4841.748586907105;4843.782029808667;4854.80580776765;4869.9269510957365;4930.1865192243595;4930.383702037246;4933.136701077297;4949.604031677457;4954.108260513142;5518.706550035427;5658.462446067617;5661.2923384576925;5662.8301150965535;5665.9716701417055;6819.556728812611;6826.795196144124;6832.419244364285;6838;6838.384545390839;1607.686501132268;1618.5629879932353;1621.481126039656;1638.8852780305265;1735.4620067779028;1132.0321125437797;1152.141654467427;1161.6573110932295;1166.6616681162368;1166.807476766341;6483.222013358427;6506.902396464056;6514.5114116441455;6527.988161834924;6532.248791389051;6881.793546193622;6909.2745261746795;6925.549839260432;6928.930710692828;6947.235804061549;6509.967450162719;6514.05546195799;6518.608883467007;6525.738970441224;6539.901901471481;3827.3110840049058;3836.8848934532007;3855.151866589346;3856.9035774105873;3860.189360234326;7355.301246381585;7398.482106252511;7400.703971841066;7440.516366436273;7448.031755871811;7152.105986751656;7295.161056478467;7328.193898671142;7339.449541284425;7351.669174887143;7350.4119670426235;7351.485396022227;7356.889646655304;7365.7790266292095;7369.557826530426;7089.716411343695;7124.21633620291;7129.3583577478275;7144.857102858018;7154.35610795031;6890.689918953759;7025.859482810213;7065.328793764585;7067.0459487968465;7068.893966590403;7368.300011498899;7405.148407933157;7405.518641288299;7417.554946703215;7424.740134095281;4797.280407938698;4798.904021919612;4826.444958829639;4843.910120222921;4849.2968519565175;6929.6833601615535;6993.615351155735;7090.893636595559;7118.359347658736;7119.394851437686;6851.486138539729;6877.793666190022;6910.067140935909;6914;6924.134483189601;6861.382475577222;6877.105976223059;6887.139107611549;6891.310868913069;6902.344277293649;6646.335366463315;6784.491163162881;6798.932010680028;6814.659267036529;6815.795526134224;6942.375186233061;6945.166580010431;6948.33990770876;6950.79147625572;6952.617606031717;6760.93239067603;6762.444637733447;6765.729370825112;6778.220504641832;6799.694013769491 03:41:54 INFO - 2015-12-25 03:41:54,243 DEBUG : BROWSER_OUTPUT: |5;yui.html;848.1942154952796;892.8883889513811;927.5269612497626;932.4964519159654;947.9289053320998;15515.68968620627;15592.610184745387;15709.371625135009;15769.369225230992;15915.124668143248;15243.542693719206;15278.38886444541;15343.386264549432;15382.923085384557;15459.45891893784;875.5578432891413;881.607684580362;905.4431524612381;906.0939060939061;913.5706218077493;903.8824952756132;907.4283201583027;910.4309806371018;911.2800887299059;914.2411798207472;948.5162567090764;953.1993125774349;955.0115630322617;955.3980991975046;956.5504213019905;937.9015203403646;940.7224868663726;941.8822647169138;945.2626950978248;946.5835032585641;702.9771682202435;703.7149954268478;703.7783098324063;705.4250785609763;706.254901079361;13637;13735.725285494334;13760.449582016707;13766.724665506734;13767;13228.805039544804;13236.801447978289;13240.602781916557;13303.201807891557;13303.467861285537;10527.684169474927;10890.673279801618;11240.606578769786;11259.54961801527;11311;3829.3681542545446;3833.6549710525906;3885.494885664874;3923.686105111613;3930.155016671401;49777;50088.74955625235;51230;52034.219486708105;52706.73646631742;10590.205734569938;10608.469576521298;10638.095761860173;10781.784364312827;10782.4069676167;18729.438116856243;18734.1569629367;18765.437036888914;18929;18955.91484936656;7863.685452581947;8031.35749140079;8061.879071813927;8077.717279895175;8129.227723366271;4571.885702857455;4602.953970460252;4606.0097079128145;4608;4643.698159619614;3160.478521044002;3248.447763880146;3249.26891449422;3255.4953982132806;3264.069740124053;577.206341280739;586.293516312842;590.0146754919296;590.3270271890049;611.1047315682547;636.3572791480638;648.9837754056186;651.7458191305394;673.0442771264816;676.4317972902687;9312.674056407994;9372.250219982385;9506.334556580972;9519.190868776093;9550.856737148948;714.8284411741145;717.8420747435556;720.7621484909968;761.5354633673455;766.0807031562148;4176.791160441966;4339.631131353807;4371.846985355497;4580.450345958507;4607;56035.71982140145;56540.15189772157;56975.43024569701;61777.691111544154;62701;50442.747786260836;50787;51534;51714;52998.205026924625;48661.270080948816;48742.75628621834;49029.26456103161;49405.25892111621;50100;9094.499802510925;9265.166135047879;9295.535223238676;9464.479453630116;9555.808883822145;36292.27415451729;36391.818040909624;36780.26439471249;36820;37076;44136.33795493135;47343.28985065296;47518.76240618775;47576.762116190584;47583;11773.17587768848;11838.467268972745;11919.761604767682;12020.218685785396;12214.08394370408;12904.161229520427;13055.281959491938;13614.38735256896;13902.930485347508;13959.162450253018;12141.210821296587;12387.07096967713;12661;12899.677508062374;13105.672358191121;11998.760024799281;12124.33316167584;12192.939035304767;12297.56958506448;12298.50805967787;11918.761624767283;12006.840598154518;12021.278723276631;12172.878271217529;12378.504859805507;10674.252802303765;10782.137429005817;10855.67432977012;10863.728406789893;11014.39437800716;10246.333988290737;10620.734481638021;10627.468626568796;10724.678259652223;10744.30162039465 03:41:54 INFO - 2015-12-25 03:41:54,244 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:41:54 INFO - 2015-12-25 03:41:54,244 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:41:54 INFO - 2015-12-25 03:41:54,244 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,302 03:41:54 INFO - 2015-12-25 03:41:54,244 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:41:54 INFO - 2015-12-25 03:41:54,244 DEBUG : BROWSER_OUTPUT: __startTimestamp1451043714230__endTimestamp 03:41:54 INFO - 2015-12-25 03:41:54,244 DEBUG : BROWSER_OUTPUT: 03:41:54 INFO - 2015-12-25 03:41:54,244 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:41:54 INFO - 2015-12-25 03:41:54,244 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:41:54 INFO - 2015-12-25 03:41:54,244 DEBUG : BROWSER_OUTPUT: 03:41:54 INFO - 2015-12-25 03:41:54,244 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5636.68 Median:5882.91 stddev:620.50 (10.5%) stddev-sans-first:595.85 03:41:54 INFO - 2015-12-25 03:41:54,244 DEBUG : BROWSER_OUTPUT: Values: 3347.5 3409.4 3413.8 3446.0 3446.1 5633.5 5636.4 5664.1 5666.6 5672.7 5565.6 5660.2 5661.5 5670.5 5707.3 5125.2 5173.0 5232.7 5236.3 5250.5 4981.7 5140.7 5147.5 5151.3 5196.9 5127.0 5177.3 5189.7 5207.2 5210.3 5160.5 5189.7 5195.8 5203.1 5239.2 4908.2 4939.8 4982.1 5085.5 5115.6 5480.2 5485.4 5499.2 5520.3 5537.9 6078.1 6129.6 6153.1 6163.0 6183.5 5891.8 5998.9 6126.4 6207.3 6234.3 5602.1 5618.1 5629.4 5649.2 5688.0 6202.8 6203.4 6203.6 6205.8 6206.2 5739.7 5781.4 5815.4 5838.9 5843.4 6009.4 6034.5 6039.5 6047.2 6052.1 5967.9 6018.5 6020.4 6028.4 6030.7 5800.5 5832.5 5854.7 5983.9 6022.5 4631.8 4650.4 4654.0 4669.2 4721.0 4194.0 4210.3 4212.4 4213.0 4226.6 5631.1 5678.4 5735.5 5791.5 5842.5 6086.3 6150.4 6194.7 6202.2 6203.6 5627.1 5887.0 5890.4 5895.2 5903.5 5211.9 5259.6 5295.2 5343.4 5369.4 6160.7 6173.9 6221.7 6235.4 6242.8 5939.3 6032.1 6080.9 6089.3 6096.0 6147.9 6258.9 6282.3 6293.4 6317.7 5948.8 5987.3 5988.8 6013.5 6034.5 5953.5 5979.6 6058.3 6126.7 6151.0 5960.7 6018.7 6033.7 6043.6 6057.1 5928.2 6002.8 6009.7 6012.6 6013.0 5712.3 5863.9 5885.2 5910.1 5925.6 5937.5 5947.2 6020.4 6061.8 6080.0 5808.0 5882.9 5887.1 5910.7 5916.6 03:41:54 INFO - 2015-12-25 03:41:54,244 DEBUG : BROWSER_OUTPUT: 03:41:54 INFO - 2015-12-25 03:41:54,244 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:60066.13 Median:22469.30 stddev:132548.85 (589.9%) stddev-sans-first:132845.48 03:41:54 INFO - 2015-12-25 03:41:54,245 DEBUG : BROWSER_OUTPUT: Values: 597.3 612.8 630.6 633.9 680.3 39158.6 39957.4 39978.4 40091.6 40132.2 40850.8 41339.0 41422.0 41539.6 41565.2 8890.1 9028.7 9045.1 9049.4 9053.9 8825.2 8899.9 8925.1 8939.9 8966.0 8837.5 8908.9 8944.0 8953.2 8965.5 8905.8 8917.8 8928.3 8966.7 8967.6 8806.8 8920.4 8921.9 8967.3 8981.9 38242.4 38355.6 38814.0 38877.2 38949.2 3604.6 3707.5 4087.8 4307.7 4400.6 31250.7 31748.2 31858.5 31988.4 32052.5 4275.6 4294.5 4332.5 4355.6 4367.2 281137.0 285202.0 286104.0 286839.0 287484.0 44547.6 45016.0 57900.4 58172.4 58189.0 45940.8 45971.0 45977.8 46114.0 46270.0 14734.7 14791.3 14930.8 14988.3 15154.7 11015.7 11109.4 11119.8 11139.4 11167.4 15518.9 15541.7 15583.2 15611.3 15629.4 5875.6 6056.8 6068.7 6074.2 6149.5 977.6 1086.2 1087.2 1099.0 1103.4 27572.4 27822.7 28177.0 28266.6 28605.9 1094.1 1101.6 1115.9 1121.7 1137.8 14293.6 14299.9 14383.7 14684.9 14730.3 692805.0 695902.0 707554.0 777032.0 784731.0 55992.7 56441.2 56769.4 56896.7 56913.1 1416.3 1433.8 1439.5 1450.1 1461.2 29848.7 32045.7 32785.3 32831.5 33618.3 52841.0 52946.5 52992.2 53040.0 53276.7 329093.0 329907.0 330934.0 332395.0 332646.0 42807.4 43345.0 44652.6 44721.6 44830.8 47747.5 47912.3 47965.5 48126.5 48255.0 40222.4 40734.2 43512.0 45134.8 45702.5 37926.0 38311.8 38808.6 38922.6 38935.8 38012.8 38103.2 42638.4 43355.0 43800.6 32082.8 33669.8 33768.7 34153.3 34344.1 25857.0 26004.3 26012.0 26229.6 26394.0 03:41:54 INFO - 2015-12-25 03:41:54,245 DEBUG : BROWSER_OUTPUT: 03:41:54 INFO - 2015-12-25 03:41:54,245 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32740.97 Median:2020.53 stddev:107358.75 (5313.4%) stddev-sans-first:107632.44 03:41:54 INFO - 2015-12-25 03:41:54,246 DEBUG : BROWSER_OUTPUT: Values: 393.7 396.6 398.2 399.6 400.8 15843.1 16221.2 17417.6 17793.7 17812.2 11616.2 12364.4 17252.7 18393.1 18520.3 5026.6 5287.4 5288.6 5291.2 5294.4 5099.5 5219.7 5223.5 5229.0 5232.0 5146.5 5193.3 5199.2 5203.5 5328.4 5291.9 5319.8 5327.8 5343.1 5358.8 5505.2 5511.1 5517.4 5520.1 5521.5 12715.1 13209.7 13246.4 13565.1 13726.9 2179.7 2221.8 2269.1 2276.1 2316.6 9908.5 10060.5 12664.4 13142.6 13903.2 1979.4 2049.9 2050.9 2123.7 2128.3 61493.4 66767.7 67255.3 67375.0 67705.3 10964.3 10966.9 11015.1 11028.1 11080.3 14326.2 14421.2 14452.1 14468.3 14519.7 7880.4 7922.0 7922.9 7928.7 7969.2 7618.3 7649.7 7680.0 7706.7 7717.3 4710.2 4721.1 4737.5 4743.5 4927.3 1910.4 1931.5 1952.1 1958.6 1991.2 883.6 942.4 962.7 972.5 1044.5 17268.5 17555.6 17817.3 17824.5 18076.6 982.2 983.4 1003.8 1008.3 1030.1 9973.5 10079.7 10150.9 10177.3 10212.1 638901.0 640549.0 648382.0 677198.0 680193.0 82875.0 84081.0 85549.0 86142.0 87707.6 1122.1 1130.1 1133.8 1140.5 1143.5 15455.5 15758.8 15845.4 15864.8 16118.0 36440.6 36498.5 37210.1 37784.6 38208.2 49122.8 49170.8 50726.0 51000.7 51021.5 9971.6 10300.5 10343.1 10388.6 10434.9 17623.6 17944.4 18117.0 18146.1 18474.5 14316.1 14522.9 14665.3 15264.8 15451.8 11437.6 15454.0 15482.4 15918.6 16126.2 16115.8 16221.8 16242.0 16595.4 16609.9 9994.8 10383.5 10417.3 10442.8 10566.6 11133.7 12499.7 15923.8 16206.0 16356.3 03:41:54 INFO - 2015-12-25 03:41:54,246 DEBUG : BROWSER_OUTPUT: 03:41:54 INFO - 2015-12-25 03:41:54,246 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5451.86 Median:6545.26 stddev:2749.04 (42.0%) stddev-sans-first:2740.05 03:41:54 INFO - 2015-12-25 03:41:54,246 DEBUG : BROWSER_OUTPUT: Values: 1421.6 1472.4 1659.1 1835.5 1845.4 7290.6 7692.9 7754.7 7764.4 7815.1 7792.4 7869.5 7912.1 7929.1 7945.1 2341.3 2360.8 2376.8 2385.2 2389.4 2319.5 2373.0 2389.2 2389.7 2389.8 2317.8 2350.9 2362.3 2369.6 2381.9 2316.0 2333.5 2364.1 2397.0 2401.3 2342.4 2376.3 2378.1 2378.3 2401.3 7667.8 7738.2 7756.4 7760.1 7769.3 4651.5 4757.2 4763.5 4773.8 4776.1 3109.1 3118.4 3182.2 3202.3 3225.7 1105.6 1113.6 1119.5 1141.9 1142.2 10423.0 10492.0 10492.4 10525.4 10551.3 4112.8 4192.6 4199.5 4203.3 4235.1 8618.5 8643.9 8657.7 8662.1 8674.7 4687.0 4694.9 4716.3 4719.6 4736.3 4324.5 4335.1 4339.1 4340.8 4351.0 3550.6 3611.6 3613.1 3624.2 3653.6 1096.7 1099.2 1105.6 1118.1 1198.0 999.0 1019.4 1033.6 1215.2 1432.8 7262.9 7371.6 7457.4 7470.4 7476.6 1158.8 1166.1 1178.2 1201.2 1202.7 5872.6 5962.7 5968.3 6017.8 6019.9 9238.5 9240.3 9292.8 9320.9 9383.2 8958.4 9070.8 9227.1 9227.9 9267.0 7295.1 7368.4 7382.0 7382.9 7390.0 7018.6 7042.0 7050.2 7074.3 7098.5 8056.9 8108.4 8192.8 8211.5 8286.0 8282.3 8364.7 8365.0 8373.4 8482.5 6632.3 6663.1 6701.2 6703.6 6712.0 7427.1 7452.3 7471.7 7493.8 7522.8 6754.2 6756.4 6837.9 6973.8 7145.6 6731.5 6876.5 6911.7 6941.9 7009.0 7046.5 7081.4 7093.7 7106.3 7135.9 6526.1 6564.4 6588.0 6596.3 6610.6 6453.9 6608.3 6646.2 6674.0 6686.4 03:41:54 INFO - 2015-12-25 03:41:54,246 DEBUG : BROWSER_OUTPUT: 03:41:54 INFO - 2015-12-25 03:41:54,247 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5706.52 Median:6495.06 stddev:1736.33 (26.7%) stddev-sans-first:1694.22 03:41:54 INFO - 2015-12-25 03:41:54,247 DEBUG : BROWSER_OUTPUT: Values: 361.6 362.5 362.7 364.9 370.9 6163.7 6327.8 6344.5 6345.0 6423.5 6142.0 6329.3 6329.5 6340.8 6344.8 4842.2 4866.5 4869.8 4894.0 4895.5 4907.5 4911.5 4915.5 4917.0 4919.9 4759.7 4848.6 4851.8 4853.6 4865.2 4838.4 4838.5 4838.5 4840.7 4848.8 4257.8 4267.9 4268.5 4278.5 4282.3 5911.8 5992.4 5997.6 5998.6 5998.9 5657.7 5660.1 5662.9 5669.7 5670.5 6698.0 6708.4 6709.7 6716.0 6727.8 4736.8 4738.0 4741.4 4744.5 4748.0 6878.2 7023.2 7032.2 7032.8 7045.9 4831.3 4841.7 4843.8 4854.8 4869.9 4930.2 4930.4 4933.1 4949.6 4954.1 5518.7 5658.5 5661.3 5662.8 5666.0 6819.6 6826.8 6832.4 6838.0 6838.4 1607.7 1618.6 1621.5 1638.9 1735.5 1132.0 1152.1 1161.7 1166.7 1166.8 6483.2 6506.9 6514.5 6528.0 6532.2 6881.8 6909.3 6925.5 6928.9 6947.2 6510.0 6514.1 6518.6 6525.7 6539.9 3827.3 3836.9 3855.2 3856.9 3860.2 7355.3 7398.5 7400.7 7440.5 7448.0 7152.1 7295.2 7328.2 7339.4 7351.7 7350.4 7351.5 7356.9 7365.8 7369.6 7089.7 7124.2 7129.4 7144.9 7154.4 6890.7 7025.9 7065.3 7067.0 7068.9 7368.3 7405.1 7405.5 7417.6 7424.7 4797.3 4798.9 4826.4 4843.9 4849.3 6929.7 6993.6 7090.9 7118.4 7119.4 6851.5 6877.8 6910.1 6914.0 6924.1 6861.4 6877.1 6887.1 6891.3 6902.3 6646.3 6784.5 6798.9 6814.7 6815.8 6942.4 6945.2 6948.3 6950.8 6952.6 6760.9 6762.4 6765.7 6778.2 6799.7 03:41:54 INFO - 2015-12-25 03:41:54,247 DEBUG : BROWSER_OUTPUT: 03:41:54 INFO - 2015-12-25 03:41:54,247 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14633.26 Median:4591.70 stddev:16501.78 (359.4%) stddev-sans-first:16515.60 03:41:54 INFO - 2015-12-25 03:41:54,248 DEBUG : BROWSER_OUTPUT: Values: 848.2 892.9 927.5 932.5 947.9 15515.7 15592.6 15709.4 15769.4 15915.1 15243.5 15278.4 15343.4 15382.9 15459.5 875.6 881.6 905.4 906.1 913.6 903.9 907.4 910.4 911.3 914.2 948.5 953.2 955.0 955.4 956.6 937.9 940.7 941.9 945.3 946.6 703.0 703.7 703.8 705.4 706.3 13637.0 13735.7 13760.4 13766.7 13767.0 13228.8 13236.8 13240.6 13303.2 13303.5 10527.7 10890.7 11240.6 11259.5 11311.0 3829.4 3833.7 3885.5 3923.7 3930.2 49777.0 50088.7 51230.0 52034.2 52706.7 10590.2 10608.5 10638.1 10781.8 10782.4 18729.4 18734.2 18765.4 18929.0 18955.9 7863.7 8031.4 8061.9 8077.7 8129.2 4571.9 4603.0 4606.0 4608.0 4643.7 3160.5 3248.4 3249.3 3255.5 3264.1 577.2 586.3 590.0 590.3 611.1 636.4 649.0 651.7 673.0 676.4 9312.7 9372.3 9506.3 9519.2 9550.9 714.8 717.8 720.8 761.5 766.1 4176.8 4339.6 4371.8 4580.5 4607.0 56035.7 56540.2 56975.4 61777.7 62701.0 50442.7 50787.0 51534.0 51714.0 52998.2 48661.3 48742.8 49029.3 49405.3 50100.0 9094.5 9265.2 9295.5 9464.5 9555.8 36292.3 36391.8 36780.3 36820.0 37076.0 44136.3 47343.3 47518.8 47576.8 47583.0 11773.2 11838.5 11919.8 12020.2 12214.1 12904.2 13055.3 13614.4 13902.9 13959.2 12141.2 12387.1 12661.0 12899.7 13105.7 11998.8 12124.3 12192.9 12297.6 12298.5 11918.8 12006.8 12021.3 12172.9 12378.5 10674.3 10782.1 10855.7 10863.7 11014.4 10246.3 10620.7 10627.5 10724.7 10744.3 03:41:54 INFO - 2015-12-25 03:41:54,248 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:41:54 INFO - 2015-12-25 03:41:54,248 DEBUG : BROWSER_OUTPUT: 03:41:54 INFO - 2015-12-25 03:41:54,974 INFO : Browser exited with error code: 0 03:41:54 INFO - 2015-12-25 03:41:54,993 INFO : Completed test dromaeo_css (00:18:28) 03:41:54 INFO - 2015-12-25 03:41:54,993 INFO : Starting test kraken 03:41:54 INFO - 2015-12-25 03:41:54,993 DEBUG : operating with platform_type : linux_ 03:41:54 INFO - 2015-12-25 03:41:54,993 INFO : Initialising browser for kraken test... 03:41:54 INFO - 2015-12-25 03:41:54,999 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOXxxIe/profile http://localhost:59058/getInfo.html 03:41:59 INFO - 2015-12-25 03:41:59,407 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:41:59 INFO - 2015-12-25 03:41:59,407 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:41:59 INFO - 2015-12-25 03:41:59,407 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 03:41:59 INFO - 2015-12-25 03:41:59,407 DEBUG : BROWSER_OUTPUT: __metrics 03:42:00 INFO - 2015-12-25 03:42:00,410 INFO : Browser initialized. 03:42:00 INFO - 2015-12-25 03:42:00,410 INFO : Running cycle 1/1 for kraken test... 03:42:00 INFO - 2015-12-25 03:42:00,411 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpOXxxIe/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:42:12 INFO - 2015-12-25 03:42:12,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 138448896 03:42:12 INFO - 2015-12-25 03:42:12,198 DEBUG : BROWSER_OUTPUT: 03:42:14 INFO - 2015-12-25 03:42:14,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59058/tests/kraken/driver.html?testName=audio-beat-detection) 03:42:15 INFO - 2015-12-25 03:42:15,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 138137600 03:42:15 INFO - 2015-12-25 03:42:15,259 DEBUG : BROWSER_OUTPUT: 03:42:17 INFO - 2015-12-25 03:42:17,876 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59058/tests/kraken/driver.html?testName=audio-dft) 03:42:18 INFO - 2015-12-25 03:42:18,477 DEBUG : BROWSER_OUTPUT: RSS: Main: 138760192 03:42:18 INFO - 2015-12-25 03:42:18,478 DEBUG : BROWSER_OUTPUT: 03:42:21 INFO - 2015-12-25 03:42:21,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59058/tests/kraken/driver.html?testName=audio-fft) 03:42:21 INFO - 2015-12-25 03:42:21,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 139743232 03:42:21 INFO - 2015-12-25 03:42:21,882 DEBUG : BROWSER_OUTPUT: 03:42:23 INFO - 2015-12-25 03:42:23,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59058/tests/kraken/driver.html?testName=audio-oscillator) 03:42:24 INFO - 2015-12-25 03:42:24,479 DEBUG : BROWSER_OUTPUT: RSS: Main: 139804672 03:42:24 INFO - 2015-12-25 03:42:24,479 DEBUG : BROWSER_OUTPUT: 03:42:26 INFO - 2015-12-25 03:42:26,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59058/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:42:27 INFO - 2015-12-25 03:42:27,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 138350592 03:42:27 INFO - 2015-12-25 03:42:27,261 DEBUG : BROWSER_OUTPUT: 03:42:30 INFO - 2015-12-25 03:42:30,213 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59058/tests/kraken/driver.html?testName=imaging-darkroom) 03:42:30 INFO - 2015-12-25 03:42:30,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 139603968 03:42:30 INFO - 2015-12-25 03:42:30,799 DEBUG : BROWSER_OUTPUT: 03:42:34 INFO - 2015-12-25 03:42:34,183 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59058/tests/kraken/driver.html?testName=imaging-desaturate) 03:42:34 INFO - 2015-12-25 03:42:34,776 DEBUG : BROWSER_OUTPUT: RSS: Main: 139309056 03:42:34 INFO - 2015-12-25 03:42:34,776 DEBUG : BROWSER_OUTPUT: 03:42:37 INFO - 2015-12-25 03:42:37,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59058/tests/kraken/driver.html?testName=json-parse-financial) 03:42:38 INFO - 2015-12-25 03:42:38,142 DEBUG : BROWSER_OUTPUT: RSS: Main: 137752576 03:42:38 INFO - 2015-12-25 03:42:38,142 DEBUG : BROWSER_OUTPUT: 03:42:39 INFO - 2015-12-25 03:42:39,716 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59058/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:42:40 INFO - 2015-12-25 03:42:40,285 DEBUG : BROWSER_OUTPUT: RSS: Main: 138104832 03:42:40 INFO - 2015-12-25 03:42:40,286 DEBUG : BROWSER_OUTPUT: 03:42:42 INFO - 2015-12-25 03:42:42,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59058/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:42:42 INFO - 2015-12-25 03:42:42,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 138424320 03:42:42 INFO - 2015-12-25 03:42:42,675 DEBUG : BROWSER_OUTPUT: 03:42:44 INFO - 2015-12-25 03:42:44,691 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59058/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:42:45 INFO - 2015-12-25 03:42:45,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 139169792 03:42:45 INFO - 2015-12-25 03:42:45,278 DEBUG : BROWSER_OUTPUT: 03:42:47 INFO - 2015-12-25 03:42:47,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59058/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:42:48 INFO - 2015-12-25 03:42:48,292 DEBUG : BROWSER_OUTPUT: RSS: Main: 139628544 03:42:48 INFO - 2015-12-25 03:42:48,292 DEBUG : BROWSER_OUTPUT: 03:42:50 INFO - 2015-12-25 03:42:50,848 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59058/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:42:51 INFO - 2015-12-25 03:42:51,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 138608640 03:42:51 INFO - 2015-12-25 03:42:51,434 DEBUG : BROWSER_OUTPUT: 03:42:53 INFO - 2015-12-25 03:42:53,104 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59058/tests/kraken/driver.html?testName=ai-astar) 03:42:53 INFO - 2015-12-25 03:42:53,355 DEBUG : BROWSER_OUTPUT: RSS: Main: 140099584 03:42:53 INFO - 2015-12-25 03:42:53,355 DEBUG : BROWSER_OUTPUT: 03:42:53 INFO - 2015-12-25 03:42:53,356 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:42:53 INFO - 2015-12-25 03:42:53,357 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:42:53 INFO - 2015-12-25 03:42:53,357 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:42:53 INFO - 2015-12-25 03:42:53,357 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:42:53 INFO - 2015-12-25 03:42:53,357 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;105;113;112;111;120;111;110;109;112 03:42:53 INFO - 2015-12-25 03:42:53,357 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;121;151;157;123;151;162;129;170;125 03:42:53 INFO - 2015-12-25 03:42:53,357 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;159;161;161;164;162;162;163;163;162 03:42:53 INFO - 2015-12-25 03:42:53,357 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;73;159;72;72;71;72;159;74 03:42:53 INFO - 2015-12-25 03:42:53,358 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;95;139;92;93;92;141;93;92;133 03:42:53 INFO - 2015-12-25 03:42:53,358 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;110;110;110;110;109;110 03:42:53 INFO - 2015-12-25 03:42:53,358 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;148;147;147;145;146;147;146;145;146 03:42:53 INFO - 2015-12-25 03:42:53,358 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;97;97;96;98;96 03:42:53 INFO - 2015-12-25 03:42:53,358 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;61;60;60;61;60;60;62;67;60;60 03:42:53 INFO - 2015-12-25 03:42:53,358 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;64;64;65;65;65;64;64;64;64 03:42:53 INFO - 2015-12-25 03:42:53,358 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;80;81;82;88;89;81;81;81;82 03:42:53 INFO - 2015-12-25 03:42:53,359 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;130;124;115;122;129;122;114;128;116 03:42:53 INFO - 2015-12-25 03:42:53,359 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;160;147;151;154;144;144;145;150;151;135 03:42:53 INFO - 2015-12-25 03:42:53,359 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;65;67;64;72;66;64;71;64;67 03:42:53 INFO - 2015-12-25 03:42:53,359 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:42:53 INFO - 2015-12-25 03:42:53,359 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:42:53 INFO - 2015-12-25 03:42:53,359 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,708 03:42:53 INFO - 2015-12-25 03:42:53,359 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:42:53 INFO - 2015-12-25 03:42:53,360 DEBUG : BROWSER_OUTPUT: __startTimestamp1451043773355__endTimestamp 03:42:53 INFO - 2015-12-25 03:42:53,360 DEBUG : BROWSER_OUTPUT: 03:42:53 INFO - 2015-12-25 03:42:53,363 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:42:53 INFO - 2015-12-25 03:42:53,363 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:42:53 INFO - 2015-12-25 03:42:53,364 DEBUG : BROWSER_OUTPUT: 03:42:53 INFO - 2015-12-25 03:42:53,364 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.70 Median:112.00 stddev:3.83 (3.4%) stddev-sans-first:3.97 03:42:53 INFO - 2015-12-25 03:42:53,364 DEBUG : BROWSER_OUTPUT: Values: 114.0 105.0 113.0 112.0 111.0 120.0 111.0 110.0 109.0 112.0 03:42:53 INFO - 2015-12-25 03:42:53,364 DEBUG : BROWSER_OUTPUT: 03:42:53 INFO - 2015-12-25 03:42:53,365 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.40 Median:153.00 stddev:18.08 (11.8%) stddev-sans-first:18.77 03:42:53 INFO - 2015-12-25 03:42:53,365 DEBUG : BROWSER_OUTPUT: Values: 155.0 121.0 151.0 157.0 123.0 151.0 162.0 129.0 170.0 125.0 03:42:53 INFO - 2015-12-25 03:42:53,365 DEBUG : BROWSER_OUTPUT: 03:42:53 INFO - 2015-12-25 03:42:53,365 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.40 (0.9%) stddev-sans-first:1.45 03:42:53 INFO - 2015-12-25 03:42:53,366 DEBUG : BROWSER_OUTPUT: Values: 161.0 159.0 161.0 161.0 164.0 162.0 162.0 163.0 163.0 162.0 03:42:53 INFO - 2015-12-25 03:42:53,366 DEBUG : BROWSER_OUTPUT: 03:42:53 INFO - 2015-12-25 03:42:53,366 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.80 Median:72.00 stddev:36.48 (50.7%) stddev-sans-first:38.25 03:42:53 INFO - 2015-12-25 03:42:53,366 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 73.0 159.0 72.0 72.0 71.0 72.0 159.0 74.0 03:42:53 INFO - 2015-12-25 03:42:53,366 DEBUG : BROWSER_OUTPUT: 03:42:53 INFO - 2015-12-25 03:42:53,366 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.30 Median:92.50 stddev:21.75 (23.5%) stddev-sans-first:22.53 03:42:53 INFO - 2015-12-25 03:42:53,366 DEBUG : BROWSER_OUTPUT: Values: 93.0 95.0 139.0 92.0 93.0 92.0 141.0 93.0 92.0 133.0 03:42:53 INFO - 2015-12-25 03:42:53,366 DEBUG : BROWSER_OUTPUT: 03:42:53 INFO - 2015-12-25 03:42:53,367 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 03:42:53 INFO - 2015-12-25 03:42:53,367 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 03:42:53 INFO - 2015-12-25 03:42:53,367 DEBUG : BROWSER_OUTPUT: 03:42:53 INFO - 2015-12-25 03:42:53,367 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 03:42:53 INFO - 2015-12-25 03:42:53,367 DEBUG : BROWSER_OUTPUT: Values: 148.0 148.0 147.0 147.0 145.0 146.0 147.0 146.0 145.0 146.0 03:42:53 INFO - 2015-12-25 03:42:53,367 DEBUG : BROWSER_OUTPUT: 03:42:53 INFO - 2015-12-25 03:42:53,367 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 03:42:53 INFO - 2015-12-25 03:42:53,367 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 97.0 97.0 96.0 98.0 96.0 03:42:53 INFO - 2015-12-25 03:42:53,367 DEBUG : BROWSER_OUTPUT: 03:42:53 INFO - 2015-12-25 03:42:53,369 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.10 Median:60.50 stddev:2.18 (3.6%) stddev-sans-first:2.32 03:42:53 INFO - 2015-12-25 03:42:53,369 DEBUG : BROWSER_OUTPUT: Values: 61.0 60.0 60.0 61.0 60.0 60.0 62.0 67.0 60.0 60.0 03:42:53 INFO - 2015-12-25 03:42:53,369 DEBUG : BROWSER_OUTPUT: 03:42:53 INFO - 2015-12-25 03:42:53,369 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 03:42:53 INFO - 2015-12-25 03:42:53,369 DEBUG : BROWSER_OUTPUT: Values: 64.0 64.0 64.0 65.0 65.0 65.0 64.0 64.0 64.0 64.0 03:42:53 INFO - 2015-12-25 03:42:53,369 DEBUG : BROWSER_OUTPUT: 03:42:53 INFO - 2015-12-25 03:42:53,369 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:81.50 stddev:3.24 (4.0%) stddev-sans-first:3.31 03:42:53 INFO - 2015-12-25 03:42:53,369 DEBUG : BROWSER_OUTPUT: Values: 80.0 80.0 81.0 82.0 88.0 89.0 81.0 81.0 81.0 82.0 03:42:53 INFO - 2015-12-25 03:42:53,369 DEBUG : BROWSER_OUTPUT: 03:42:53 INFO - 2015-12-25 03:42:53,369 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:123.00 stddev:5.94 (4.8%) stddev-sans-first:6.14 03:42:53 INFO - 2015-12-25 03:42:53,369 DEBUG : BROWSER_OUTPUT: Values: 118.0 130.0 124.0 115.0 122.0 129.0 122.0 114.0 128.0 116.0 03:42:53 INFO - 2015-12-25 03:42:53,369 DEBUG : BROWSER_OUTPUT: 03:42:53 INFO - 2015-12-25 03:42:53,369 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.10 Median:150.50 stddev:6.77 (4.5%) stddev-sans-first:5.65 03:42:53 INFO - 2015-12-25 03:42:53,369 DEBUG : BROWSER_OUTPUT: Values: 160.0 147.0 151.0 154.0 144.0 144.0 145.0 150.0 151.0 135.0 03:42:53 INFO - 2015-12-25 03:42:53,369 DEBUG : BROWSER_OUTPUT: 03:42:53 INFO - 2015-12-25 03:42:53,369 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:66.50 stddev:2.84 (4.3%) stddev-sans-first:3.00 03:42:53 INFO - 2015-12-25 03:42:53,370 DEBUG : BROWSER_OUTPUT: Values: 66.0 65.0 67.0 64.0 72.0 66.0 64.0 71.0 64.0 67.0 03:42:53 INFO - 2015-12-25 03:42:53,370 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:42:53 INFO - 2015-12-25 03:42:53,370 DEBUG : BROWSER_OUTPUT: 03:42:54 INFO - 2015-12-25 03:42:54,254 INFO : Browser exited with error code: 0 03:42:54 INFO - 2015-12-25 03:42:54,304 INFO : Completed test kraken (00:00:59) 03:42:54 INFO - 2015-12-25 03:42:54,304 INFO : Starting test v8_7 03:42:54 INFO - 2015-12-25 03:42:54,304 DEBUG : operating with platform_type : linux_ 03:42:54 INFO - 2015-12-25 03:42:54,304 INFO : Initialising browser for v8_7 test... 03:42:54 INFO - 2015-12-25 03:42:54,310 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8MKkQR/profile http://localhost:59058/getInfo.html 03:42:58 INFO - 2015-12-25 03:42:58,629 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:42:58 INFO - 2015-12-25 03:42:58,629 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:42:58 INFO - 2015-12-25 03:42:58,630 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/670 03:42:58 INFO - 2015-12-25 03:42:58,630 DEBUG : BROWSER_OUTPUT: __metrics 03:42:59 INFO - 2015-12-25 03:42:59,686 INFO : Browser initialized. 03:42:59 INFO - 2015-12-25 03:42:59,686 INFO : Running cycle 1/1 for v8_7 test... 03:42:59 INFO - 2015-12-25 03:42:59,687 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8MKkQR/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:43:11 INFO - 2015-12-25 03:43:11,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 138321920 03:43:11 INFO - 2015-12-25 03:43:11,458 DEBUG : BROWSER_OUTPUT: 03:43:32 INFO - 2015-12-25 03:43:32,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59058/tests/v8_7/run.html (next: http://localhost:59058/tests/v8_7/run.html) 03:43:33 INFO - 2015-12-25 03:43:33,086 DEBUG : BROWSER_OUTPUT: RSS: Main: 136318976 03:43:33 INFO - 2015-12-25 03:43:33,086 DEBUG : BROWSER_OUTPUT: 03:43:33 INFO - 2015-12-25 03:43:33,086 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:43:33 INFO - 2015-12-25 03:43:33,087 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:43:33 INFO - 2015-12-25 03:43:33,087 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:43:33 INFO - 2015-12-25 03:43:33,087 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:43:33 INFO - 2015-12-25 03:43:33,087 DEBUG : BROWSER_OUTPUT: |0;Richards;166.55562958027983 03:43:33 INFO - 2015-12-25 03:43:33,088 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.04031839418585 03:43:33 INFO - 2015-12-25 03:43:33,088 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.55153203342616 03:43:33 INFO - 2015-12-25 03:43:33,088 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5235.602094240838 03:43:33 INFO - 2015-12-25 03:43:33,088 DEBUG : BROWSER_OUTPUT: |4;RayTrace;946.073793755913 03:43:33 INFO - 2015-12-25 03:43:33,088 DEBUG : BROWSER_OUTPUT: |5;Earley;550.05500550055 03:43:33 INFO - 2015-12-25 03:43:33,088 DEBUG : BROWSER_OUTPUT: |6;Boyer;11076.923076923076 03:43:33 INFO - 2015-12-25 03:43:33,089 DEBUG : BROWSER_OUTPUT: |7;RegExp;24261.904761904763 03:43:33 INFO - 2015-12-25 03:43:33,089 DEBUG : BROWSER_OUTPUT: |8;Splay;522.1932114882507 03:43:33 INFO - 2015-12-25 03:43:33,089 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4817.307692307692 03:43:33 INFO - 2015-12-25 03:43:33,089 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:43:33 INFO - 2015-12-25 03:43:33,089 DEBUG : BROWSER_OUTPUT: __startTimestamp1451043813084__endTimestamp 03:43:33 INFO - 2015-12-25 03:43:33,089 DEBUG : BROWSER_OUTPUT: 03:43:33 INFO - 2015-12-25 03:43:33,090 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:43:33 INFO - 2015-12-25 03:43:33,090 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:43:33 INFO - 2015-12-25 03:43:33,090 DEBUG : BROWSER_OUTPUT: 03:43:33 INFO - 2015-12-25 03:43:33,090 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.56 Median:166.56 stddev:0.00 (0.0%) 03:43:33 INFO - 2015-12-25 03:43:33,091 DEBUG : BROWSER_OUTPUT: Values: 166.6 03:43:33 INFO - 2015-12-25 03:43:33,091 DEBUG : BROWSER_OUTPUT: 03:43:33 INFO - 2015-12-25 03:43:33,091 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.04 Median:173.04 stddev:0.00 (0.0%) 03:43:33 INFO - 2015-12-25 03:43:33,091 DEBUG : BROWSER_OUTPUT: Values: 173.0 03:43:33 INFO - 2015-12-25 03:43:33,091 DEBUG : BROWSER_OUTPUT: 03:43:33 INFO - 2015-12-25 03:43:33,092 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 03:43:33 INFO - 2015-12-25 03:43:33,092 DEBUG : BROWSER_OUTPUT: Values: 278.6 03:43:33 INFO - 2015-12-25 03:43:33,092 DEBUG : BROWSER_OUTPUT: 03:43:33 INFO - 2015-12-25 03:43:33,092 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5235.60 Median:5235.60 stddev:0.00 (0.0%) 03:43:33 INFO - 2015-12-25 03:43:33,093 DEBUG : BROWSER_OUTPUT: Values: 5235.6 03:43:33 INFO - 2015-12-25 03:43:33,093 DEBUG : BROWSER_OUTPUT: 03:43:33 INFO - 2015-12-25 03:43:33,093 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:946.07 Median:946.07 stddev:0.00 (0.0%) 03:43:33 INFO - 2015-12-25 03:43:33,093 DEBUG : BROWSER_OUTPUT: Values: 946.1 03:43:33 INFO - 2015-12-25 03:43:33,093 DEBUG : BROWSER_OUTPUT: 03:43:33 INFO - 2015-12-25 03:43:33,093 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:550.06 Median:550.06 stddev:0.00 (0.0%) 03:43:33 INFO - 2015-12-25 03:43:33,094 DEBUG : BROWSER_OUTPUT: Values: 550.1 03:43:33 INFO - 2015-12-25 03:43:33,094 DEBUG : BROWSER_OUTPUT: 03:43:33 INFO - 2015-12-25 03:43:33,094 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11076.92 Median:11076.92 stddev:0.00 (0.0%) 03:43:33 INFO - 2015-12-25 03:43:33,094 DEBUG : BROWSER_OUTPUT: Values: 11076.9 03:43:33 INFO - 2015-12-25 03:43:33,094 DEBUG : BROWSER_OUTPUT: 03:43:33 INFO - 2015-12-25 03:43:33,095 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24261.90 Median:24261.90 stddev:0.00 (0.0%) 03:43:33 INFO - 2015-12-25 03:43:33,095 DEBUG : BROWSER_OUTPUT: Values: 24261.9 03:43:33 INFO - 2015-12-25 03:43:33,095 DEBUG : BROWSER_OUTPUT: 03:43:33 INFO - 2015-12-25 03:43:33,095 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:522.19 Median:522.19 stddev:0.00 (0.0%) 03:43:33 INFO - 2015-12-25 03:43:33,095 DEBUG : BROWSER_OUTPUT: Values: 522.2 03:43:33 INFO - 2015-12-25 03:43:33,095 DEBUG : BROWSER_OUTPUT: 03:43:33 INFO - 2015-12-25 03:43:33,096 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 03:43:33 INFO - 2015-12-25 03:43:33,096 DEBUG : BROWSER_OUTPUT: Values: 4817.3 03:43:33 INFO - 2015-12-25 03:43:33,096 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:43:33 INFO - 2015-12-25 03:43:33,096 DEBUG : BROWSER_OUTPUT: 03:43:33 INFO - 2015-12-25 03:43:33,998 INFO : Browser exited with error code: 0 03:43:34 INFO - 2015-12-25 03:43:34,013 INFO : Completed test v8_7 (00:00:39) 03:43:34 INFO - 2015-12-25 03:43:34,153 INFO : Completed test suite (00:20:07) 03:43:34 INFO - 2015-12-25 03:43:34,153 DEBUG : Working with test: dromaeo_css 03:43:34 INFO - 2015-12-25 03:43:34,153 DEBUG : Generating results file: dromaeo_css 03:43:34 INFO - 2015-12-25 03:43:34,154 DEBUG : Working with test: kraken 03:43:34 INFO - 2015-12-25 03:43:34,155 DEBUG : Generating results file: kraken 03:43:34 INFO - 2015-12-25 03:43:34,155 INFO : javascript benchmark 03:43:34 INFO - 2015-12-25 03:43:34,155 DEBUG : Working with test: v8_7 03:43:34 INFO - 2015-12-25 03:43:34,155 DEBUG : Generating results file: v8_7 03:43:34 INFO - 2015-12-25 03:43:34,156 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:43:34 INFO - 2015-12-25 03:43:34,211 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 03:43:34 INFO - 2015-12-25 03:43:34,211 DEBUG : process_Request line: dromaeo_css 7373.79 graph.html#tests=[[72,52,43]] 03:43:34 INFO - 2015-12-25 03:43:34,211 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:43:34 INFO - 2015-12-25 03:43:34,251 DEBUG : process_Request line: kraken 1511.10 graph.html#tests=[[232,52,43]] 03:43:34 INFO - 2015-12-25 03:43:34,251 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:43:34 INFO - 2015-12-25 03:43:34,368 DEBUG : process_Request line: v8_7 23037.57 graph.html#tests=[[230,52,43]] 03:43:34 INFO - 2015-12-25 03:43:34,370 INFO : javascript benchmark 03:43:34 INFO - 2015-12-25 03:43:34,373 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3347.497875318702, 3409.403354412977, 3413.7951722896614, 3445.9827700861492, 3446.069561218472, 5633.521150702185, 5636.4363563643665, 5664.0937450008005, 5666.631668941516, 5672.744726487308, 5565.6104072714925, 5660.235868157797, 5661.490465858072, 5670.5463562914865, 5707.343655479621, 5125.154349532323, 5173.0, 5232.686038837682, 5236.2931004314505, 5250.501202385767, 4981.676191047589, 5140.742962851842, 5147.48525147486, 5151.278820965049, 5196.8700782480555, 5126.974365128169, 5177.32694749682, 5189.6886186828915, 5207.192885102796, 5210.296609957664, 5160.509751573594, 5189.714565698904, 5195.766190521435, 5203.115470370046, 5239.21411788231, 4908.239222920453, 4939.777710003059, 4982.103221420143, 5085.542301192911, 5115.565176959963, 5480.150576660624, 5485.396606373296, 5499.202615620713, 5520.337559492847, 5537.889242215133, 6078.057901025348, 6129.632222066691, 6153.077038444225, 6163.013917773134, 6183.536234782365, 5891.764329426818, 5998.880022399571, 6126.356732543063, 6207.34822843604, 6234.251889773211, 5602.1036634138345, 5618.073017952033, 5629.3526244482, 5649.2091107244605, 5688.004599195125, 6202.81391558254, 6203.379662033761, 6203.596766210182, 6205.751769929152, 6206.193194884636, 5739.741711622987, 5781.421857814269, 5815.41845815415, 5838.94161058384, 5843.386444423274, 6009.369016253318, 6034.456898879122, 6039.516838652898, 6047.244094488189, 6052.092186172022, 5967.880642387128, 6018.458338749533, 6020.397960204032, 6028.4272994065495, 6030.728617212236, 5800.50695690871, 5832.475077243069, 5854.7072646367515, 5983.940160598426, 6022.5483088768515, 4631.791569379386, 4650.395448591661, 4654.045920586272, 4669.159551280802, 4720.976395118002, 4194.0, 4210.32634778434, 4212.410262563244, 4212.978935105305, 4226.556211597799, 5631.099024156116, 5678.375378708339, 5735.4551317624755, 5791.536677065825, 5842.474177324061, 6086.269647642312, 6150.354212807681, 6194.721237544321, 6202.224721909762, 6203.596766210182, 5627.099664053731, 5887.028640274392, 5890.352061273256, 5895.20414744004, 5903.498202652737, 5211.947880521222, 5259.552938000236, 5295.205719142083, 5343.4389389113585, 5369.4362091980565, 6160.691965401712, 6173.9073913891325, 6221.720022598994, 6235.376462353728, 6242.750289988349, 5939.287285525765, 6032.095185722177, 6080.90878636812, 6089.2997305310455, 6095.969520152459, 6147.877042459037, 6258.874822503615, 6282.308946016026, 6293.37066293367, 6317.652529110943, 5948.762049517971, 5987.34139244674, 5988.820335389945, 6013.458788708862, 6034.487068599218, 5953.464188223081, 5979.5814292999075, 6058.303295121117, 6126.693665316628, 6151.0, 5960.701964901824, 6018.699065046642, 6033.698315084316, 6043.607165534227, 6057.091436284416, 5928.170056192223, 6002.819915402545, 6009.729562169626, 6012.579119461596, 6012.969935150296, 5712.285964254468, 5863.912041319299, 5885.234919460443, 5910.113482977587, 5925.644461332334, 5937.524998000236, 5947.226860508106, 6020.397960203944, 6061.818145455643, 6080.027195648675, 5807.970960145172, 5882.911756323573, 5887.116932460165, 5910.734016969161, 5916.55625828056], "unit": "ms", "name": "dojo.html", "value": 5596.868035756473}, {"lowerIsBetter": false, "replicates": [597.2832600878945, 612.8192183305924, 630.6027202862197, 633.8859005379036, 680.2890978927021, 39158.608413915856, 39957.400638990366, 39978.40032399516, 40091.599084009154, 40132.197356052864, 40850.7957460213, 41339.0, 41422.0, 41539.58460415395, 41565.168696626046, 8890.066543012988, 9028.68399606014, 9045.140711632384, 9049.411788233743, 9053.864192037125, 8825.161609647073, 8899.866502002475, 8925.062868398822, 8939.910600894005, 8965.95517022414, 8837.513936733478, 8908.910910890905, 8944.0, 8953.194212520872, 8965.462072275652, 8905.777355566099, 8917.821643567126, 8928.285737141014, 8966.686165984192, 8967.596458159398, 8806.767052612575, 8920.420172688819, 8921.910780892238, 8967.282617390592, 8981.865272020925, 38242.42636360429, 38355.61644383548, 38814.0, 38877.22245555101, 38949.22101557982, 3604.6034936157002, 3707.5180226570374, 4087.7956102195067, 4307.655387568987, 4400.6259467945265, 31250.687493125006, 31748.20629484258, 31858.522122168186, 31988.360232795214, 32052.519212211835, 4275.551067137968, 4294.484661840599, 4332.501762297313, 4355.5644435556505, 4367.192069467159, 281137.0, 285201.9999999979, 286104.0, 286839.0, 287484.0, 44547.55452445434, 45016.0, 57900.4209957895, 58172.418275817545, 58189.0, 45940.77029614831, 45971.0, 45977.77011114923, 46114.0, 46270.0, 14734.705305893822, 14791.260436978324, 14930.776038359434, 14988.325525351385, 15154.696906062038, 11015.669529914116, 11109.44452777358, 11119.777604447865, 11139.443027848574, 11167.441627918572, 15518.9224053879, 15541.689166216613, 15583.220838958006, 15611.297491612904, 15629.374825006873, 5875.588708790344, 6056.757729690851, 6068.666223357758, 6074.179985701874, 6149.5080393568405, 977.5552123783662, 1086.2342048855537, 1087.2226358153957, 1098.9724607492021, 1103.4151899493281, 27572.44855102927, 27822.721772782013, 28177.0, 28266.576001359997, 28605.85697071543, 1094.0919037199264, 1101.5813990683648, 1115.938623375722, 1121.6803211084803, 1137.82932560115, 14293.57119286423, 14299.85700143006, 14383.712325753635, 14684.926575367268, 14730.337134828958, 692805.0, 695902.0, 707554.0, 777032.0, 784731.0, 55992.72003639956, 56441.15338269929, 56769.43230567641, 56896.715516422984, 56913.14630280549, 1416.2847761880184, 1433.7992681024664, 1439.4673970630934, 1450.144414795276, 1461.2474575593578, 29848.701512984593, 32045.67954320427, 32785.34429311448, 32831.507527387585, 33618.32763344768, 52841.0, 52946.47053529415, 52992.20511692405, 53040.0, 53276.73361633167, 329093.0, 329907.0, 330934.0, 332395.0, 332646.0, 42807.3578896323, 43345.0, 44652.55347446614, 44721.55278447304, 44830.77584612056, 47747.52252477431, 47912.2813157796, 47965.5203447975, 48126.518734812205, 48255.0, 40222.39666405065, 40734.185316294104, 43512.0, 45134.77432612816, 45702.54297457116, 37926.02358017056, 38311.80844095762, 38808.6119138805, 38922.6107738919, 38935.805320974345, 38012.80993595014, 38103.2379352417, 42638.36042459303, 43355.0, 43800.56199437965, 32082.83958580192, 33669.83165084257, 33768.66231337655, 34153.31693366069, 34344.14139646529, 25857.0, 26004.34989125287, 26012.0, 26229.606555902057, 26394.0], "unit": "ms", "name": "ext.html", "value": 19519.869981639116}, {"lowerIsBetter": false, "replicates": [393.722262167456, 396.58952983661914, 398.24731257922525, 399.57046175361484, 400.79759721340736, 15843.12862792549, 16221.188940552984, 17417.564560885985, 17793.7330940036, 17812.19845106972, 11616.186866919319, 12364.381780910964, 17252.741208881846, 18393.080345982682, 18520.259189632397, 5026.623003274751, 5287.418383977779, 5288.550473209782, 5291.2327712481665, 5294.41761406245, 5099.490050994889, 5219.739013049332, 5223.503767142115, 5229.0, 5232.032074066291, 5146.485351464861, 5193.298904647881, 5199.220116982445, 5203.531682148606, 5328.387235467912, 5291.86770330741, 5319.787208511655, 5327.760250788685, 5343.118385466393, 5358.812441564546, 5505.229267902497, 5511.145772405243, 5517.393086760453, 5520.1443776214755, 5521.503064724194, 12715.109942304043, 13209.669758256121, 13246.403911823894, 13565.118267312593, 13726.931365343109, 2179.7493288271894, 2221.8444708870384, 2269.126386341254, 2276.089564174327, 2316.6061769499224, 9908.504574771232, 10060.547275372626, 12664.4301006454, 13142.605721828264, 13903.165810051429, 1979.4457551885496, 2049.897505124738, 2050.8872012039333, 2123.692064650617, 2128.2763860287578, 61493.38506614921, 66767.66616166936, 67255.3274467254, 67375.0, 67705.3229467704, 10964.342139471657, 10966.945165274283, 11015.118790496741, 11028.117750579935, 11080.279781814317, 14326.212058336683, 14421.20683362404, 14452.060616059922, 14468.27658617065, 14519.709605807824, 7880.369570434352, 7921.960390198127, 7922.920770792333, 7928.7224947127725, 7969.163237859942, 7618.314351708373, 7649.655765490566, 7680.0, 7706.653200605986, 7717.2668596483245, 4710.24636058229, 4721.1265915805, 4737.45519265282, 4743.478217396084, 4927.334809800703, 1910.436421255733, 1931.4591914264029, 1952.1215453046186, 1958.6474434601907, 1991.153759652142, 883.5758835758871, 942.4157022646003, 962.7256231973854, 972.4505654305295, 1044.4516628769957, 17268.481945541655, 17555.561110972074, 17817.287308507774, 17824.46526604204, 18076.638467230583, 982.1995074014656, 983.4296108257194, 1003.8494225866178, 1008.2639673038576, 1030.0523518363125, 9973.451460169761, 10079.69760907174, 10150.949245253727, 10177.287589868638, 10212.131968782736, 638901.0, 640549.0, 648382.0, 677198.0, 680193.0, 82875.0, 84081.0, 85549.0, 86142.0, 87707.56146219229, 1122.0686829931137, 1130.0902773267435, 1133.795916734979, 1140.4582823158933, 1143.5082914346744, 15455.459058932884, 15758.763618545501, 15845.366185352457, 15864.76202856935, 16118.0, 36440.635593643725, 36498.45252321164, 37210.06974825651, 37784.62215377811, 38208.23583528258, 49122.75438622784, 49170.75414622904, 50726.0, 51000.74499627478, 51021.48978510316, 9971.551280192554, 10300.484975751033, 10343.120834729132, 10388.584456621651, 10434.895651043393, 17623.559411014827, 17944.37194698179, 18117.0, 18146.092695364914, 18474.538136546693, 14316.141031538142, 14522.927385363428, 14665.26673666291, 15264.847351526787, 15451.768223476882, 11437.59968401102, 15454.0, 15482.380704772133, 15918.602034948755, 16126.193690315671, 16115.838841611434, 16221.756673650141, 16242.025478471329, 16595.41916032933, 16609.916950415653, 9994.750131246778, 10383.480825958823, 10417.322874013165, 10442.791144177227, 10566.630167944086, 11133.721656958642, 12499.687507812378, 15923.840761592235, 16206.0, 16356.34574617002], "unit": "ms", "name": "jquery.html", "value": 9262.037556291052}, {"lowerIsBetter": false, "replicates": [1421.6374824419772, 1472.4331132513983, 1659.145540046876, 1835.5044138082726, 1845.3817970979712, 7290.599017054066, 7692.884606730903, 7754.728584499537, 7764.378849692018, 7815.101263354716, 7792.376609871211, 7869.488483248585, 7912.090109637379, 7929.088154862193, 7945.12603613602, 2341.309313752439, 2360.8347415680823, 2376.7979721723673, 2385.2486466763003, 2389.378761522008, 2319.4549280918973, 2373.027058905849, 2389.175734371639, 2389.665446837444, 2389.784919357266, 2317.8261630377706, 2350.8589484630893, 2362.338545207345, 2369.6445533170076, 2381.880905954704, 2315.98096837391, 2333.474968132157, 2364.148906393697, 2396.9880150599224, 2401.2796161151587, 2342.355852140658, 2376.251480783565, 2378.120095564635, 2378.322178179228, 2401.2556107606697, 7667.846643067163, 7738.226177382273, 7756.379489640815, 7760.06879174497, 7769.339606133485, 4651.488336283006, 4757.1912774828015, 4763.499832517605, 4773.832915847964, 4776.140294746944, 3109.0828205679377, 3118.3607360491274, 3182.1726351148636, 3202.327511222646, 3225.709686128236, 1105.5798796457295, 1113.560143743217, 1119.4514687802919, 1141.925774824642, 1142.1719253541198, 10423.0, 10491.999999999924, 10492.422916739577, 10525.36847789135, 10551.261411701184, 4112.835486580503, 4192.559781222989, 4199.517055538591, 4203.348480985452, 4235.131797981407, 8618.482891026433, 8643.913560864437, 8657.653693852302, 8662.090480499583, 8674.739757807276, 4686.976565117153, 4694.929576056362, 4716.292556116541, 4719.622430205575, 4736.265878788793, 4324.459442569679, 4335.111302183045, 4339.088791353851, 4340.826366945287, 4351.0, 3550.6449355064287, 3611.63883611642, 3613.0786649404236, 3624.1664417184197, 3653.5615726112505, 1096.71485413793, 1099.2085698297212, 1105.5577768892508, 1118.116687816632, 1197.958071467512, 998.9550470228858, 1019.3628981886321, 1033.5504055735778, 1215.2222577550199, 1432.7564314066633, 7262.891056634155, 7371.557706537625, 7457.440691948017, 7470.439717021245, 7476.626168691544, 1158.7798318319492, 1166.084623570493, 1178.192937837584, 1201.159188568006, 1202.663254288783, 5872.559558033165, 5962.731677074542, 5968.253968253968, 6017.849553761103, 6019.909701354483, 9238.538073096319, 9240.306976976754, 9292.814143717087, 9320.8601870972, 9383.202427793578, 8958.417702849294, 9070.820793296829, 9227.123423274777, 9227.90772092284, 9266.953665231631, 7295.124585049722, 7368.373688236453, 7382.0034295370515, 7382.889256661155, 7389.963050184715, 7018.613976231356, 7042.0, 7050.189228238613, 7074.257202993817, 7098.538594991515, 8056.879146812919, 8108.3513318933165, 8192.795180120307, 8211.507309561446, 8285.964254468192, 8282.296004839414, 8364.665413383396, 8365.038020627706, 8373.37199710012, 8482.491050536988, 6632.336766323329, 6663.067170596023, 6701.195856497252, 6703.597784132968, 6712.0, 7427.108746950401, 7452.292032256927, 7471.6637751302405, 7493.812654683677, 7522.774316770506, 6754.155730533684, 6756.358145976124, 6837.897431538431, 6973.79078627642, 7145.642717863982, 6731.495137864582, 6876.518643694893, 6911.723531058701, 6941.861162776817, 7009.0, 7046.4715146363205, 7081.362677358857, 7093.680784364613, 7106.253843346581, 7135.892961605477, 6526.086347911391, 6564.442022427956, 6588.0, 6596.340365963365, 6610.570312929644, 6453.903191452226, 6608.306127856506, 6646.202455705346, 6674.032265321598, 6686.431653309329], "unit": "ms", "name": "mootools.html", "value": 4526.056573295079}, {"lowerIsBetter": false, "replicates": [361.62571738250915, 362.52994108888464, 362.66634696079615, 364.93978493548565, 370.8942951258891, 6163.660998645073, 6327.841803954903, 6344.492440604752, 6345.0, 6423.486121110317, 6142.0, 6329.272133704625, 6329.49364050876, 6340.778072767454, 6344.777932772354, 4842.152623290927, 4866.537678920515, 4869.756512174395, 4894.045661096087, 4895.461499235082, 4907.460179380265, 4911.533404326583, 4915.483874193212, 4917.041176970492, 4919.926201106986, 4759.690620109682, 4848.563629273364, 4851.781669824849, 4853.611711063124, 4865.172920603506, 4838.371011768483, 4838.467768545457, 4838.516148385133, 4840.685355451919, 4848.830290939818, 4257.8296868125235, 4267.850625228102, 4268.466441694788, 4278.465191851019, 4282.293421585435, 5911.763529458816, 5992.43071908168, 5997.580169388145, 5998.580099393044, 5998.880022399528, 5657.745401456944, 5660.066089095294, 5662.858428539278, 5669.659820410789, 5670.5463562914865, 6698.0, 6708.362705542965, 6709.6980635871505, 6715.966420167868, 6727.788997980361, 4736.786844592001, 4737.952620473786, 4741.383620129361, 4744.478107408182, 4747.952520474785, 6878.174619045746, 7023.157221133446, 7032.226455089987, 7032.789016329467, 7045.929540704578, 4831.251156070814, 4841.748586907105, 4843.782029808667, 4854.80580776765, 4869.9269510957365, 4930.1865192243595, 4930.383702037246, 4933.136701077297, 4949.604031677457, 4954.108260513142, 5518.706550035427, 5658.462446067617, 5661.2923384576925, 5662.8301150965535, 5665.9716701417055, 6819.556728812611, 6826.795196144124, 6832.419244364285, 6838.0, 6838.384545390839, 1607.686501132268, 1618.5629879932353, 1621.481126039656, 1638.8852780305265, 1735.4620067779028, 1132.0321125437797, 1152.141654467427, 1161.6573110932295, 1166.6616681162368, 1166.807476766341, 6483.222013358427, 6506.902396464056, 6514.5114116441455, 6527.988161834924, 6532.248791389051, 6881.793546193622, 6909.2745261746795, 6925.549839260432, 6928.930710692828, 6947.235804061549, 6509.967450162719, 6514.05546195799, 6518.608883467007, 6525.738970441224, 6539.901901471481, 3827.3110840049058, 3836.8848934532007, 3855.151866589346, 3856.9035774105873, 3860.189360234326, 7355.301246381585, 7398.482106252511, 7400.703971841066, 7440.516366436273, 7448.031755871811, 7152.105986751656, 7295.161056478467, 7328.193898671142, 7339.449541284425, 7351.669174887143, 7350.4119670426235, 7351.485396022227, 7356.889646655304, 7365.7790266292095, 7369.557826530426, 7089.716411343695, 7124.21633620291, 7129.3583577478275, 7144.857102858018, 7154.35610795031, 6890.689918953759, 7025.859482810213, 7065.328793764585, 7067.0459487968465, 7068.893966590403, 7368.300011498899, 7405.148407933157, 7405.518641288299, 7417.554946703215, 7424.740134095281, 4797.280407938698, 4798.904021919612, 4826.444958829639, 4843.910120222921, 4849.2968519565175, 6929.6833601615535, 6993.615351155735, 7090.893636595559, 7118.359347658736, 7119.394851437686, 6851.486138539729, 6877.793666190022, 6910.067140935909, 6914.0, 6924.134483189601, 6861.382475577222, 6877.105976223059, 6887.139107611549, 6891.310868913069, 6902.344277293649, 6646.335366463315, 6784.491163162881, 6798.932010680028, 6814.659267036529, 6815.795526134224, 6942.375186233061, 6945.166580010431, 6948.33990770876, 6950.79147625572, 6952.617606031717, 6760.93239067603, 6762.444637733447, 6765.729370825112, 6778.220504641832, 6799.694013769491], "unit": "ms", "name": "prototype.html", "value": 5140.618115768821}, {"lowerIsBetter": false, "replicates": [848.1942154952796, 892.8883889513811, 927.5269612497626, 932.4964519159654, 947.9289053320998, 15515.68968620627, 15592.610184745387, 15709.371625135009, 15769.369225230992, 15915.124668143248, 15243.542693719206, 15278.38886444541, 15343.386264549432, 15382.923085384557, 15459.45891893784, 875.5578432891413, 881.607684580362, 905.4431524612381, 906.0939060939061, 913.5706218077493, 903.8824952756132, 907.4283201583027, 910.4309806371018, 911.2800887299059, 914.2411798207472, 948.5162567090764, 953.1993125774349, 955.0115630322617, 955.3980991975046, 956.5504213019905, 937.9015203403646, 940.7224868663726, 941.8822647169138, 945.2626950978248, 946.5835032585641, 702.9771682202435, 703.7149954268478, 703.7783098324063, 705.4250785609763, 706.254901079361, 13637.0, 13735.725285494334, 13760.449582016707, 13766.724665506734, 13767.0, 13228.805039544804, 13236.801447978289, 13240.602781916557, 13303.201807891557, 13303.467861285537, 10527.684169474927, 10890.673279801618, 11240.606578769786, 11259.54961801527, 11311.0, 3829.3681542545446, 3833.6549710525906, 3885.494885664874, 3923.686105111613, 3930.155016671401, 49777.0, 50088.74955625235, 51230.0, 52034.219486708105, 52706.73646631742, 10590.205734569938, 10608.469576521298, 10638.095761860173, 10781.784364312827, 10782.4069676167, 18729.438116856243, 18734.1569629367, 18765.437036888914, 18929.0, 18955.91484936656, 7863.685452581947, 8031.35749140079, 8061.879071813927, 8077.717279895175, 8129.227723366271, 4571.885702857455, 4602.953970460252, 4606.0097079128145, 4608.0, 4643.698159619614, 3160.478521044002, 3248.447763880146, 3249.26891449422, 3255.4953982132806, 3264.069740124053, 577.206341280739, 586.293516312842, 590.0146754919296, 590.3270271890049, 611.1047315682547, 636.3572791480638, 648.9837754056186, 651.7458191305394, 673.0442771264816, 676.4317972902687, 9312.674056407994, 9372.250219982385, 9506.334556580972, 9519.190868776093, 9550.856737148948, 714.8284411741145, 717.8420747435556, 720.7621484909968, 761.5354633673455, 766.0807031562148, 4176.791160441966, 4339.631131353807, 4371.846985355497, 4580.450345958507, 4607.0, 56035.71982140145, 56540.15189772157, 56975.43024569701, 61777.691111544154, 62701.0, 50442.747786260836, 50787.0, 51534.0, 51714.0, 52998.205026924625, 48661.270080948816, 48742.75628621834, 49029.26456103161, 49405.25892111621, 50100.0, 9094.499802510925, 9265.166135047879, 9295.535223238676, 9464.479453630116, 9555.808883822145, 36292.27415451729, 36391.818040909624, 36780.26439471249, 36820.0, 37076.0, 44136.33795493135, 47343.28985065296, 47518.76240618775, 47576.762116190584, 47583.0, 11773.17587768848, 11838.467268972745, 11919.761604767682, 12020.218685785396, 12214.08394370408, 12904.161229520427, 13055.281959491938, 13614.38735256896, 13902.930485347508, 13959.162450253018, 12141.210821296587, 12387.07096967713, 12661.0, 12899.677508062374, 13105.672358191121, 11998.760024799281, 12124.33316167584, 12192.939035304767, 12297.56958506448, 12298.50805967787, 11918.761624767283, 12006.840598154518, 12021.278723276631, 12172.878271217529, 12378.504859805507, 10674.252802303765, 10782.137429005817, 10855.67432977012, 10863.728406789893, 11014.39437800716, 10246.333988290737, 10620.734481638021, 10627.468626568796, 10724.678259652223, 10744.30162039465], "unit": "ms", "name": "yui.html", "value": 6827.201114929589}], "name": "dromaeo_css", "value": 7373.788143931386}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 105.0, 113.0, 112.0, 111.0, 120.0, 111.0, 110.0, 109.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 111.7}, {"lowerIsBetter": true, "replicates": [155.0, 121.0, 151.0, 157.0, 123.0, 151.0, 162.0, 129.0, 170.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.4}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 161.0, 161.0, 164.0, 162.0, 162.0, 163.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 73.0, 159.0, 72.0, 72.0, 71.0, 72.0, 159.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 89.8}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 139.0, 92.0, 93.0, 92.0, 141.0, 93.0, 92.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 106.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 147.0, 145.0, 146.0, 147.0, 146.0, 145.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 98.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [61.0, 60.0, 60.0, 61.0, 60.0, 60.0, 62.0, 67.0, 60.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 61.1}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 64.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.3}, {"lowerIsBetter": true, "replicates": [80.0, 80.0, 81.0, 82.0, 88.0, 89.0, 81.0, 81.0, 81.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.5}, {"lowerIsBetter": true, "replicates": [118.0, 130.0, 124.0, 115.0, 122.0, 129.0, 122.0, 114.0, 128.0, 116.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.8}, {"lowerIsBetter": true, "replicates": [160.0, 147.0, 151.0, 154.0, 144.0, 144.0, 145.0, 150.0, 151.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.1}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 67.0, 64.0, 72.0, 66.0, 64.0, 71.0, 64.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1511.0999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.55562958027983], "unit": "score", "name": "Richards", "value": 211.95320800000005}, {"lowerIsBetter": false, "replicates": [173.04031839418585], "unit": "score", "name": "DeltaBlue", "value": 382.095922}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5235.602094240838], "unit": "score", "name": "Decrypt", "value": 50.84057100000005}, {"lowerIsBetter": false, "replicates": [946.073793755913], "unit": "score", "name": "RayTrace", "value": 782.1683729999996}, {"lowerIsBetter": false, "replicates": [550.05500550055], "unit": "score", "name": "Earley", "value": 1211.629734}, {"lowerIsBetter": false, "replicates": [11076.923076923076], "unit": "score", "name": "Boyer", "value": 60.16679861111106}, {"lowerIsBetter": false, "replicates": [24261.904761904763], "unit": "score", "name": "RegExp", "value": 37.547958783120734}, {"lowerIsBetter": false, "replicates": [522.1932114882507], "unit": "score", "name": "Splay", "value": 156.055265}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 23037.56887885352}]} 03:43:34 INFO - RETURN: dromaeo_css: 7373.79 03:43:34 INFO - RETURN: kraken: 1511.10 03:43:34 INFO - RETURN: v8_7: 23037.57 03:43:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23037.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1511.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7373.79"}}} 03:43:34 INFO - Return code: 0 03:43:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 03:43:34 INFO - # TBPL SUCCESS # 03:43:34 INFO - Running post-action listener: _resource_record_post_action 03:43:34 INFO - Running post-run listener: _resource_record_post_run 03:43:35 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 4096; Write bytes: 515547136; Read time: 36; Write time: 407796 03:43:35 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 237371392; Read time: 0; Write time: 287776 03:43:35 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 278175744; Read time: 36; Write time: 120020 03:43:35 INFO - Running post-run listener: _upload_blobber_files 03:43:35 INFO - Blob upload gear active. 03:43:35 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:43:35 INFO - Copying logs to upload dir... 03:43:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1268.010763 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-25 03:43:33.802694) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-25 03:43:33.806532) ========= 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=e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/NG1CtesbRJeMIi3bWvEdhw/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010016 build_url: 'https://queue.taskcluster.net/v1/task/NG1CtesbRJeMIi3bWvEdhw/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-25 03:43:33.858104) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 03:43:33.858454) ========= 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=e10134013339c31d8d0c4708000001d6-1451037366.469919-2020544121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-25 03:43:33.908215) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 03:43:33.908657) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-25 03:43:33.908994) ========= ========= Total master_lag: 0.28 =========