builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1451597489.05 results: success (0) buildid: 20151231110317 builduid: 34ceea65a3214c6992ce6e5d31cbf2c7 revision: c02ba5b2cd2f3f2f9e58f1ff8d5944af3e0adb1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.054482) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.054965) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.055261) ========= 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=fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006262 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.089829) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.090292) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.107191) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.107482) ========= 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=fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.156489) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.156803) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.157179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.157484) ========= 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=fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-31 13:31:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-12-31 13:31:29 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.169868 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.339956) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.340269) ========= 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=fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020342 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.390215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.390596) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c02ba5b2cd2f3f2f9e58f1ff8d5944af3e0adb1c --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 c02ba5b2cd2f3f2f9e58f1ff8d5944af3e0adb1c --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=fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-31 13:31:30,022 truncating revision to first 12 chars 2015-12-31 13:31:30,023 Setting DEBUG logging. 2015-12-31 13:31:30,023 attempt 1/10 2015-12-31 13:31:30,023 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c02ba5b2cd2f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-31 13:31:30,279 unpacking tar archive at: mozilla-aurora-c02ba5b2cd2f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.578082 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.981758) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.982067) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.992282) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.992653) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 13:31:29.993103) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-12-31 13:31:29.993436) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:31:30 INFO - MultiFileLogger online at 20151231 13:31:30 in /builds/slave/test-pgo 13:31:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:31:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:31:30 INFO - {'append_to_log': False, 13:31:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:31:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:31:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:31:30 INFO - 'branch': 'Mozilla-Aurora', 13:31:30 INFO - 'buildbot_json_path': 'buildprops.json', 13:31:30 INFO - 'config_files': ('talos/linux_config.py',), 13:31:30 INFO - 'default_actions': ('clobber', 13:31:30 INFO - 'read-buildbot-config', 13:31:30 INFO - 'download-and-extract', 13:31:30 INFO - 'populate-webroot', 13:31:30 INFO - 'create-virtualenv', 13:31:30 INFO - 'install', 13:31:30 INFO - 'run-tests'), 13:31:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:31:30 INFO - 'download_minidump_stackwalk': True, 13:31:30 INFO - 'download_symbols': 'ondemand', 13:31:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:31:30 INFO - 'tooltool.py': '/tools/tooltool.py', 13:31:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:31:30 INFO - '/tools/misc-python/virtualenv.py')}, 13:31:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:31:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:31:30 INFO - 'installer_path': 'installer.exe', 13:31:30 INFO - 'log_level': 'info', 13:31:30 INFO - 'log_name': 'talos', 13:31:30 INFO - 'log_to_console': True, 13:31:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:31:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:31:30 INFO - 'opt_config_files': (), 13:31:30 INFO - 'pip_index': False, 13:31:30 INFO - 'sps_profile': False, 13:31:30 INFO - 'sps_profile_interval': 0, 13:31:30 INFO - 'suite': 'dromaeojs-e10s', 13:31:30 INFO - 'system_bits': '32', 13:31:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:31:30 INFO - 'title': 'talos-linux64-ix-046', 13:31:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:31:30 INFO - 'use_talos_json': True, 13:31:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:31:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:31:30 INFO - 'work_dir': 'build'} 13:31:30 INFO - ##### 13:31:30 INFO - ##### Running clobber step. 13:31:30 INFO - ##### 13:31:30 INFO - Running pre-action listener: _resource_record_pre_action 13:31:30 INFO - Running main action method: clobber 13:31:30 INFO - rmtree: /builds/slave/test-pgo/build 13:31:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:31:31 INFO - Running post-action listener: _resource_record_post_action 13:31:31 INFO - ##### 13:31:31 INFO - ##### Running read-buildbot-config step. 13:31:31 INFO - ##### 13:31:31 INFO - Running pre-action listener: _resource_record_pre_action 13:31:31 INFO - Running main action method: read_buildbot_config 13:31:31 INFO - Using buildbot properties: 13:31:31 INFO - { 13:31:31 INFO - "properties": { 13:31:31 INFO - "buildnumber": 33, 13:31:31 INFO - "product": "firefox", 13:31:31 INFO - "script_repo_revision": "production", 13:31:31 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 13:31:31 INFO - "repository": "", 13:31:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 13:31:31 INFO - "buildid": "20151231110317", 13:31:31 INFO - "slavename": "talos-linux64-ix-046", 13:31:31 INFO - "pgo_build": "True", 13:31:31 INFO - "basedir": "/builds/slave/test-pgo", 13:31:31 INFO - "project": "", 13:31:31 INFO - "platform": "ubuntu64_hw", 13:31:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:31:31 INFO - "slavebuilddir": "test", 13:31:31 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:31:31 INFO - "branch": "mozilla-aurora", 13:31:31 INFO - "repo_path": "releases/mozilla-aurora", 13:31:31 INFO - "stage_platform": "linux64-pgo", 13:31:31 INFO - "builduid": "34ceea65a3214c6992ce6e5d31cbf2c7", 13:31:31 INFO - "revision": "c02ba5b2cd2f3f2f9e58f1ff8d5944af3e0adb1c" 13:31:31 INFO - }, 13:31:31 INFO - "sourcestamp": { 13:31:31 INFO - "repository": "", 13:31:31 INFO - "hasPatch": false, 13:31:31 INFO - "project": "", 13:31:31 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 13:31:31 INFO - "changes": [ 13:31:31 INFO - { 13:31:31 INFO - "category": null, 13:31:31 INFO - "files": [ 13:31:31 INFO - { 13:31:31 INFO - "url": null, 13:31:31 INFO - "name": "https://queue.taskcluster.net/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 13:31:31 INFO - } 13:31:31 INFO - ], 13:31:31 INFO - "repository": "", 13:31:31 INFO - "rev": "c02ba5b2cd2f3f2f9e58f1ff8d5944af3e0adb1c", 13:31:31 INFO - "who": "kwierso@gmail.com", 13:31:31 INFO - "when": 1451597465, 13:31:31 INFO - "number": 7407202, 13:31:31 INFO - "comments": "Bug 1233152 - Use PersistentRooted for ParseTask script and sourceObject. r=terrence a=sylvestre", 13:31:31 INFO - "project": "", 13:31:31 INFO - "at": "Thu 31 Dec 2015 13:31:05", 13:31:31 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 13:31:31 INFO - "revlink": "", 13:31:31 INFO - "properties": [ 13:31:31 INFO - [ 13:31:31 INFO - "buildid", 13:31:31 INFO - "20151231110317", 13:31:31 INFO - "Change" 13:31:31 INFO - ], 13:31:31 INFO - [ 13:31:31 INFO - "builduid", 13:31:31 INFO - "34ceea65a3214c6992ce6e5d31cbf2c7", 13:31:31 INFO - "Change" 13:31:31 INFO - ], 13:31:31 INFO - [ 13:31:31 INFO - "pgo_build", 13:31:31 INFO - "True", 13:31:31 INFO - "Change" 13:31:31 INFO - ] 13:31:31 INFO - ], 13:31:31 INFO - "revision": "c02ba5b2cd2f3f2f9e58f1ff8d5944af3e0adb1c" 13:31:31 INFO - } 13:31:31 INFO - ], 13:31:31 INFO - "revision": "c02ba5b2cd2f3f2f9e58f1ff8d5944af3e0adb1c" 13:31:31 INFO - } 13:31:31 INFO - } 13:31:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 13:31:31 INFO - Running post-action listener: _resource_record_post_action 13:31:31 INFO - ##### 13:31:31 INFO - ##### Running download-and-extract step. 13:31:31 INFO - ##### 13:31:31 INFO - Running pre-action listener: _resource_record_pre_action 13:31:31 INFO - Running main action method: download_and_extract 13:31:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:31 INFO - https://queue.taskcluster.net/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:31:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/test_packages.json 13:31:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/test_packages.json 13:31:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:31:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:31:34 INFO - Downloaded 1302 bytes. 13:31:34 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:31:34 INFO - Using the following test package requirements: 13:31:34 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 13:31:34 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:31:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:31:34 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:31:34 INFO - u'jsshell-linux-x86_64.zip'], 13:31:34 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:31:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:31:34 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 13:31:34 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:31:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:31:34 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:31:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:31:34 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:31:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:31:34 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 13:31:34 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 13:31:34 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:31:34 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:31: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')]} 13:31:34 INFO - https://queue.taskcluster.net/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:31:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:31:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:31:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/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 13:31:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/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 13:31:36 INFO - Downloaded 23024175 bytes. 13:31:36 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 13:31:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:31:36 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 13:31:37 INFO - Return code: 0 13:31:37 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 13:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:37 INFO - https://queue.taskcluster.net/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:31:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:31:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:31:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/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 13:31:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/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 13:31:39 INFO - Downloaded 23024175 bytes. 13:31: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 13:31:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 13:31: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 13:31:40 INFO - Return code: 0 13:31: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')]} 13:31:40 INFO - https://queue.taskcluster.net/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:31:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 13:31:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 13:31:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/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 13:31:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/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 13:31:41 INFO - Downloaded 11132038 bytes. 13:31:41 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 13:31:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 13:31:41 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 13:31:41 INFO - Return code: 0 13:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:41 INFO - https://queue.taskcluster.net/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:31:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 13:31:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 13:31:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/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 13:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hCYWmdewTwamvmpQFnxjzg/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 13:31:43 INFO - Downloaded 58086246 bytes. 13:31:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 13:31:43 INFO - mkdir: /builds/slave/test-pgo/properties 13:31:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:31:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:31:43 INFO - Contents: 13:31:43 INFO - build_url:https://queue.taskcluster.net/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 13:31:43 INFO - Running post-action listener: _resource_record_post_action 13:31:43 INFO - Running post-action listener: set_extra_try_arguments 13:31:43 INFO - ##### 13:31:43 INFO - ##### Running populate-webroot step. 13:31:43 INFO - ##### 13:31:43 INFO - Running pre-action listener: _resource_record_pre_action 13:31:43 INFO - Running main action method: populate_webroot 13:31:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:31:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:31:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:31:43 INFO - '--tppagecycles', 13:31:43 INFO - '7'], 13:31:43 INFO - 'tests': ['tsvgm']}}, 13:31:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:31:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:31:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:31:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:31:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:31:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:31:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:31:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:43 INFO - 'talos_options': ['--e10s'], 13:31:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:31:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:43 INFO - 'tests': ['damp', 'tps']}, 13:31:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:43 INFO - 'talos_options': ['--e10s'], 13:31:43 INFO - 'tests': ['damp', 'tps']}, 13:31:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:31:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:31:43 INFO - 'other': {'tests': ['a11yr', 13:31:43 INFO - 'ts_paint', 13:31:43 INFO - 'tpaint', 13:31:43 INFO - 'sessionrestore', 13:31:43 INFO - 'sessionrestore_no_auto_restore']}, 13:31:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:31:43 INFO - 'tests': ['a11yr', 13:31:43 INFO - 'ts_paint', 13:31:43 INFO - 'tpaint', 13:31:43 INFO - 'sessionrestore', 13:31:43 INFO - 'sessionrestore_no_auto_restore']}, 13:31:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:31:43 INFO - 'tests': ['a11yr', 13:31:43 INFO - 'ts_paint', 13:31:43 INFO - 'tpaint', 13:31:43 INFO - 'sessionrestore', 13:31:43 INFO - 'sessionrestore_no_auto_restore']}, 13:31:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:31:43 INFO - 'tests': ['a11yr', 13:31:43 INFO - 'ts_paint', 13:31:43 INFO - 'tpaint', 13:31:43 INFO - 'sessionrestore', 13:31:43 INFO - 'sessionrestore_no_auto_restore']}, 13:31:43 INFO - 'other_l64': {'tests': ['a11yr', 13:31:43 INFO - 'ts_paint', 13:31:43 INFO - 'tpaint', 13:31:43 INFO - 'sessionrestore', 13:31:43 INFO - 'sessionrestore_no_auto_restore']}, 13:31:43 INFO - 'other_nol64': {'tests': ['a11yr', 13:31:43 INFO - 'ts_paint', 13:31:43 INFO - 'tpaint', 13:31:43 INFO - 'sessionrestore', 13:31:43 INFO - 'sessionrestore_no_auto_restore']}, 13:31:43 INFO - 'svgr': {'tests': ['tsvgx', 13:31:43 INFO - 'tsvgr_opacity', 13:31:43 INFO - 'tart', 13:31:43 INFO - 'tscrollx', 13:31:43 INFO - 'cart']}, 13:31:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:31:43 INFO - 'tests': ['tsvgx', 13:31:43 INFO - 'tsvgr_opacity', 13:31:43 INFO - 'tart', 13:31:43 INFO - 'tscrollx', 13:31:43 INFO - 'cart']}, 13:31:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:43 INFO - 'tests': ['tp5o']}, 13:31:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:43 INFO - 'talos_options': ['--e10s'], 13:31:43 INFO - 'tests': ['tp5o']}, 13:31:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:43 INFO - 'talos_options': ['--xperf_path', 13:31:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:31:43 INFO - 'tests': ['tp5n']}, 13:31:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:31:43 INFO - 'talos_options': ['--e10s', 13:31:43 INFO - '--xperf_path', 13:31:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:31:43 INFO - 'tests': ['tp5n']}}, 13:31:43 INFO - 'talos.zip': {'path': '', 13:31:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:31:43 INFO - Running post-action listener: _resource_record_post_action 13:31:43 INFO - ##### 13:31:43 INFO - ##### Running create-virtualenv step. 13:31:43 INFO - ##### 13:31:43 INFO - Running pre-action listener: _resource_record_pre_action 13:31:43 INFO - Running main action method: create_virtualenv 13:31:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:31:43 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 13:31:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:31:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:31:43 INFO - Using real prefix '/usr' 13:31:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:31:43 INFO - Installing distribute.............................................................................................................................................................................................done. 13:31:45 INFO - Installing pip.................done. 13:31:45 INFO - Return code: 0 13:31:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:45 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 0x7f583e2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dea50>, '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 0x284a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a9e0>, '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': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', '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 13:31:45 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 13:31:45 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 13:31:45 INFO - Using env: {'DISPLAY': ':0', 13:31:45 INFO - 'HOME': '/home/cltbld', 13:31:45 INFO - 'LANG': 'en_US.UTF-8', 13:31:45 INFO - 'LANGUAGE': 'en_US:en', 13:31:45 INFO - 'LOGNAME': 'cltbld', 13:31:45 INFO - 'MAIL': '/var/mail/cltbld', 13:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:45 INFO - 'MOZ_NO_REMOTE': '1', 13:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:45 INFO - 'NO_EM_RESTART': '1', 13:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:31:45 INFO - 'PWD': '/builds/slave/test-pgo', 13:31:45 INFO - 'SHELL': '/bin/bash', 13:31:45 INFO - 'SHLVL': '1', 13:31:45 INFO - 'TERM': 'linux', 13:31:45 INFO - 'TMOUT': '86400', 13:31:45 INFO - 'USER': 'cltbld', 13:31:45 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', 13:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:45 INFO - '_': '/tools/buildbot/bin/python'} 13:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:46 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 13:31:46 INFO - Cleaning up... 13:31:46 INFO - Return code: 0 13:31:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f583e2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dea50>, '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 0x284a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a9e0>, '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': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', '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 13:31:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 13:31:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:31:46 INFO - Using env: {'DISPLAY': ':0', 13:31:46 INFO - 'HOME': '/home/cltbld', 13:31:46 INFO - 'LANG': 'en_US.UTF-8', 13:31:46 INFO - 'LANGUAGE': 'en_US:en', 13:31:46 INFO - 'LOGNAME': 'cltbld', 13:31:46 INFO - 'MAIL': '/var/mail/cltbld', 13:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:46 INFO - 'MOZ_NO_REMOTE': '1', 13:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:46 INFO - 'NO_EM_RESTART': '1', 13:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:31:46 INFO - 'PWD': '/builds/slave/test-pgo', 13:31:46 INFO - 'SHELL': '/bin/bash', 13:31:46 INFO - 'SHLVL': '1', 13:31:46 INFO - 'TERM': 'linux', 13:31:46 INFO - 'TMOUT': '86400', 13:31:46 INFO - 'USER': 'cltbld', 13:31:46 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', 13:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:46 INFO - '_': '/tools/buildbot/bin/python'} 13:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:46 INFO - Downloading/unpacking psutil>=0.7.1 13:31:46 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 13:31:46 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 13:31:46 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 13:31:46 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 13:31:46 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 13:31:46 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 13:31:47 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 13:31:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:31:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:31:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:31:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:31:48 INFO - Installing collected packages: psutil 13:31:48 INFO - Running setup.py install for psutil 13:31:48 INFO - building 'psutil._psutil_linux' extension 13:31:48 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 13:31:48 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 13:31:48 INFO - building 'psutil._psutil_posix' extension 13:31:48 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 13:31:48 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 13:31:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:31:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:31:48 INFO - Successfully installed psutil 13:31:48 INFO - Cleaning up... 13:31:48 INFO - Return code: 0 13:31:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:31:48 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')]} 13:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:48 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')]} 13:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:48 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 0x7f583e2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dea50>, '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 0x284a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a9e0>, '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': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', '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 13:31:48 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 13:31:48 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 13:31:48 INFO - Using env: {'DISPLAY': ':0', 13:31:48 INFO - 'HOME': '/home/cltbld', 13:31:48 INFO - 'LANG': 'en_US.UTF-8', 13:31:48 INFO - 'LANGUAGE': 'en_US:en', 13:31:48 INFO - 'LOGNAME': 'cltbld', 13:31:48 INFO - 'MAIL': '/var/mail/cltbld', 13:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:48 INFO - 'MOZ_NO_REMOTE': '1', 13:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:48 INFO - 'NO_EM_RESTART': '1', 13:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:31:48 INFO - 'PWD': '/builds/slave/test-pgo', 13:31:48 INFO - 'SHELL': '/bin/bash', 13:31:48 INFO - 'SHLVL': '1', 13:31:48 INFO - 'TERM': 'linux', 13:31:48 INFO - 'TMOUT': '86400', 13:31:48 INFO - 'USER': 'cltbld', 13:31:48 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', 13:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:48 INFO - '_': '/tools/buildbot/bin/python'} 13:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:31:48 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 13:31:48 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 13:31:48 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 13:31:48 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 13:31:48 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 13:31:48 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 13:31:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:31:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:31:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:31:50 INFO - Installing collected packages: mozsystemmonitor 13:31:50 INFO - Running setup.py install for mozsystemmonitor 13:31:50 INFO - Successfully installed mozsystemmonitor 13:31:50 INFO - Cleaning up... 13:31:50 INFO - Return code: 0 13:31:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:31: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')]} 13:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31: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')]} 13:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31: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', '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 0x7f583e2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dea50>, '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 0x284a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a9e0>, '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': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', '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 13:31: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 13:31: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 blobuploader==1.2.4 13:31:50 INFO - Using env: {'DISPLAY': ':0', 13:31:50 INFO - 'HOME': '/home/cltbld', 13:31:50 INFO - 'LANG': 'en_US.UTF-8', 13:31:50 INFO - 'LANGUAGE': 'en_US:en', 13:31:50 INFO - 'LOGNAME': 'cltbld', 13:31:50 INFO - 'MAIL': '/var/mail/cltbld', 13:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:50 INFO - 'MOZ_NO_REMOTE': '1', 13:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:50 INFO - 'NO_EM_RESTART': '1', 13:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:31:50 INFO - 'PWD': '/builds/slave/test-pgo', 13:31:50 INFO - 'SHELL': '/bin/bash', 13:31:50 INFO - 'SHLVL': '1', 13:31:50 INFO - 'TERM': 'linux', 13:31:50 INFO - 'TMOUT': '86400', 13:31:50 INFO - 'USER': 'cltbld', 13:31:50 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', 13:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:50 INFO - '_': '/tools/buildbot/bin/python'} 13:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:50 INFO - Downloading/unpacking blobuploader==1.2.4 13:31: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 13:31: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 13:31: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 13:31: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 13:31: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 13:31: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 13:31:52 INFO - Downloading blobuploader-1.2.4.tar.gz 13:31:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:31:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:31:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:31: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 13:31: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 13:31: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 13:31: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 13:31: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 13:31: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 13:31:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:31:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:31:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:31:53 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 13:31:53 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 13:31:53 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 13:31:53 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 13:31:53 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 13:31:53 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 13:31:53 INFO - Downloading docopt-0.6.1.tar.gz 13:31:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:31:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:31:53 INFO - Installing collected packages: blobuploader, requests, docopt 13:31:53 INFO - Running setup.py install for blobuploader 13:31:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:31:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:31:53 INFO - Running setup.py install for requests 13:31:53 INFO - Running setup.py install for docopt 13:31:54 INFO - Successfully installed blobuploader requests docopt 13:31:54 INFO - Cleaning up... 13:31:54 INFO - Return code: 0 13:31:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:31: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')]} 13:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31: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')]} 13:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:54 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 0x7f583e2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dea50>, '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 0x284a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a9e0>, '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': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', '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 13:31:54 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 13:31:54 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 13:31:54 INFO - Using env: {'DISPLAY': ':0', 13:31:54 INFO - 'HOME': '/home/cltbld', 13:31:54 INFO - 'LANG': 'en_US.UTF-8', 13:31:54 INFO - 'LANGUAGE': 'en_US:en', 13:31:54 INFO - 'LOGNAME': 'cltbld', 13:31:54 INFO - 'MAIL': '/var/mail/cltbld', 13:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:54 INFO - 'MOZ_NO_REMOTE': '1', 13:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:54 INFO - 'NO_EM_RESTART': '1', 13:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:31:54 INFO - 'PWD': '/builds/slave/test-pgo', 13:31:54 INFO - 'SHELL': '/bin/bash', 13:31:54 INFO - 'SHLVL': '1', 13:31:54 INFO - 'TERM': 'linux', 13:31:54 INFO - 'TMOUT': '86400', 13:31:54 INFO - 'USER': 'cltbld', 13:31:54 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', 13:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:54 INFO - '_': '/tools/buildbot/bin/python'} 13:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:31:54 INFO - Running setup.py (path:/tmp/pip-89lGTL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:31:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:31:54 INFO - Running setup.py (path:/tmp/pip-nvp8Tz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:31:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:31:54 INFO - Running setup.py (path:/tmp/pip-TPa49d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:31:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:31:54 INFO - Running setup.py (path:/tmp/pip-pHxpRT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:31:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:31:54 INFO - Running setup.py (path:/tmp/pip-sTG3UZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:31:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:31:54 INFO - Running setup.py (path:/tmp/pip-qCnocc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:31:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:31:54 INFO - Running setup.py (path:/tmp/pip-R4s9Az-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:31:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:31:54 INFO - Running setup.py (path:/tmp/pip-8Z0p0T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:31:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:31:54 INFO - Running setup.py (path:/tmp/pip-451INw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:31:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:31:54 INFO - Running setup.py (path:/tmp/pip-2CsfL8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:31:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:31:55 INFO - Running setup.py (path:/tmp/pip-fwR0Ny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:31:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:31:55 INFO - Running setup.py (path:/tmp/pip-fcSEPM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:31:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:31:55 INFO - Running setup.py (path:/tmp/pip-cTZuNa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:31:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:31:55 INFO - Running setup.py (path:/tmp/pip-ToKzJC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:31:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:31:55 INFO - Running setup.py (path:/tmp/pip-cgqY1Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:31:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:31:55 INFO - Running setup.py (path:/tmp/pip-3HVKq9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:31:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:31:55 INFO - Running setup.py (path:/tmp/pip-ND5JRh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:31:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:31:55 INFO - Running setup.py install for manifestparser 13:31:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:31:55 INFO - Running setup.py install for mozcrash 13:31:55 INFO - Running setup.py install for mozdebug 13:31:55 INFO - Running setup.py install for mozdevice 13:31:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:31:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:31:55 INFO - Running setup.py install for mozfile 13:31:56 INFO - Running setup.py install for mozhttpd 13:31:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:31:56 INFO - Running setup.py install for mozinfo 13:31:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:31:56 INFO - Running setup.py install for mozInstall 13:31:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:31:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:31:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:31:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:31:56 INFO - Running setup.py install for mozleak 13:31:56 INFO - Running setup.py install for mozlog 13:31:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:31:56 INFO - Running setup.py install for moznetwork 13:31:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:31:56 INFO - Running setup.py install for mozprocess 13:31:56 INFO - Running setup.py install for mozprofile 13:31:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:31:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:31:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:31:56 INFO - Running setup.py install for mozrunner 13:31:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:31:57 INFO - Running setup.py install for mozscreenshot 13:31:57 INFO - Running setup.py install for moztest 13:31:57 INFO - Running setup.py install for mozversion 13:31:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:31:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:31:57 INFO - Cleaning up... 13:31:57 INFO - Return code: 0 13:31:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:31: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')]} 13:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31: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')]} 13:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:31:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f583e2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dea50>, '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 0x284a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a9e0>, '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': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', '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 13:31:57 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 13:31:57 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 13:31:57 INFO - Using env: {'DISPLAY': ':0', 13:31:57 INFO - 'HOME': '/home/cltbld', 13:31:57 INFO - 'LANG': 'en_US.UTF-8', 13:31:57 INFO - 'LANGUAGE': 'en_US:en', 13:31:57 INFO - 'LOGNAME': 'cltbld', 13:31:57 INFO - 'MAIL': '/var/mail/cltbld', 13:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:31:57 INFO - 'MOZ_NO_REMOTE': '1', 13:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:31:57 INFO - 'NO_EM_RESTART': '1', 13:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:31:57 INFO - 'PWD': '/builds/slave/test-pgo', 13:31:57 INFO - 'SHELL': '/bin/bash', 13:31:57 INFO - 'SHLVL': '1', 13:31:57 INFO - 'TERM': 'linux', 13:31:57 INFO - 'TMOUT': '86400', 13:31:57 INFO - 'USER': 'cltbld', 13:31:57 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', 13:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:31:57 INFO - '_': '/tools/buildbot/bin/python'} 13:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:31:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:31:57 INFO - Running setup.py (path:/tmp/pip-tIyLPw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:31:57 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)) 13:31:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:31:57 INFO - Running setup.py (path:/tmp/pip-gC38MJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:31:57 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)) 13:31:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:31:57 INFO - Running setup.py (path:/tmp/pip-gjciHx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:31:57 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)) 13:31:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:31:57 INFO - Running setup.py (path:/tmp/pip-oDwkFC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:31:57 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)) 13:31:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:31:57 INFO - Running setup.py (path:/tmp/pip-kCBgH2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:31:57 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)) 13:31:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:31:57 INFO - Running setup.py (path:/tmp/pip-FaS3Ai-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:31:58 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)) 13:31:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:31:58 INFO - Running setup.py (path:/tmp/pip-gE5iBZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:31:58 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)) 13:31:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:31:58 INFO - Running setup.py (path:/tmp/pip-JIkAHz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:31:58 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)) 13:31:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:31:58 INFO - Running setup.py (path:/tmp/pip-2N3xLd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:31:58 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)) 13:31:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:31:58 INFO - Running setup.py (path:/tmp/pip-a3E1fP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:31:58 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)) 13:31:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:31:58 INFO - Running setup.py (path:/tmp/pip-UJ_qMW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:31:58 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)) 13:31:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:31:58 INFO - Running setup.py (path:/tmp/pip-jnD63o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:31:58 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)) 13:31:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:31:58 INFO - Running setup.py (path:/tmp/pip-gvJzDw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:31:58 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)) 13:31:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:31:58 INFO - Running setup.py (path:/tmp/pip-OmBQYy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:31:58 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)) 13:31:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:31:58 INFO - Running setup.py (path:/tmp/pip-MVop4m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:31:58 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)) 13:31:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:31:58 INFO - Running setup.py (path:/tmp/pip-l17K6m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:31:58 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)) 13:31:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:31:58 INFO - Running setup.py (path:/tmp/pip-x2fZJi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:31:58 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)) 13:31:58 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)) 13:31:58 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)) 13:31:58 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)) 13:31:58 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)) 13:31:58 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)) 13:31:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:00 INFO - Downloading blessings-1.5.1.tar.gz 13:32:00 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 13:32:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:32:00 INFO - Installing collected packages: blessings 13:32:00 INFO - Running setup.py install for blessings 13:32:00 INFO - Successfully installed blessings 13:32:00 INFO - Cleaning up... 13:32:00 INFO - Return code: 0 13:32:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:32:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:32:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:32:00 INFO - Reading from file tmpfile_stdout 13:32:00 INFO - Current package versions: 13:32:00 INFO - argparse == 1.2.1 13:32:00 INFO - blessings == 1.5.1 13:32:00 INFO - blobuploader == 1.2.4 13:32:00 INFO - docopt == 0.6.1 13:32:00 INFO - manifestparser == 1.1 13:32:00 INFO - mozInstall == 1.12 13:32:00 INFO - mozcrash == 0.16 13:32:00 INFO - mozdebug == 0.1 13:32:00 INFO - mozdevice == 0.47 13:32:00 INFO - mozfile == 1.2 13:32:00 INFO - mozhttpd == 0.7 13:32:00 INFO - mozinfo == 0.9 13:32:00 INFO - mozleak == 0.1 13:32:00 INFO - mozlog == 3.1 13:32:00 INFO - moznetwork == 0.27 13:32:00 INFO - mozprocess == 0.22 13:32:00 INFO - mozprofile == 0.27 13:32:00 INFO - mozrunner == 6.11 13:32:00 INFO - mozscreenshot == 0.1 13:32:00 INFO - mozsystemmonitor == 0.0 13:32:00 INFO - moztest == 0.7 13:32:00 INFO - mozversion == 1.4 13:32:00 INFO - psutil == 3.1.1 13:32:00 INFO - requests == 1.2.3 13:32:00 INFO - wsgiref == 0.1.2 13:32:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:00 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 0x7f583e2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dea50>, '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 0x284a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a9e0>, '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': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', '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 13:32:00 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 13:32:00 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 13:32:00 INFO - Using env: {'DISPLAY': ':0', 13:32:00 INFO - 'HOME': '/home/cltbld', 13:32:00 INFO - 'LANG': 'en_US.UTF-8', 13:32:00 INFO - 'LANGUAGE': 'en_US:en', 13:32:00 INFO - 'LOGNAME': 'cltbld', 13:32:00 INFO - 'MAIL': '/var/mail/cltbld', 13:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:00 INFO - 'MOZ_NO_REMOTE': '1', 13:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:00 INFO - 'NO_EM_RESTART': '1', 13:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:32:00 INFO - 'PWD': '/builds/slave/test-pgo', 13:32:00 INFO - 'SHELL': '/bin/bash', 13:32:00 INFO - 'SHLVL': '1', 13:32:00 INFO - 'TERM': 'linux', 13:32:00 INFO - 'TMOUT': '86400', 13:32:00 INFO - 'USER': 'cltbld', 13:32:00 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', 13:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:00 INFO - '_': '/tools/buildbot/bin/python'} 13:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:01 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)) 13:32:01 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)) 13:32:01 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)) 13:32:01 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)) 13:32:01 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)) 13:32:01 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)) 13:32:01 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)) 13:32:01 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)) 13:32:01 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)) 13:32:01 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)) 13:32:01 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)) 13:32:01 INFO - Cleaning up... 13:32:01 INFO - Return code: 0 13:32:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:32: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')]} 13:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32: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')]} 13:32:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f583e2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dea50>, '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 0x284a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a9e0>, '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': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', '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 13:32:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 13:32:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:32:01 INFO - Using env: {'DISPLAY': ':0', 13:32:01 INFO - 'HOME': '/home/cltbld', 13:32:01 INFO - 'LANG': 'en_US.UTF-8', 13:32:01 INFO - 'LANGUAGE': 'en_US:en', 13:32:01 INFO - 'LOGNAME': 'cltbld', 13:32:01 INFO - 'MAIL': '/var/mail/cltbld', 13:32:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:01 INFO - 'MOZ_NO_REMOTE': '1', 13:32:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:01 INFO - 'NO_EM_RESTART': '1', 13:32:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:32:01 INFO - 'PWD': '/builds/slave/test-pgo', 13:32:01 INFO - 'SHELL': '/bin/bash', 13:32:01 INFO - 'SHLVL': '1', 13:32:01 INFO - 'TERM': 'linux', 13:32:01 INFO - 'TMOUT': '86400', 13:32:01 INFO - 'USER': 'cltbld', 13:32:01 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', 13:32:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:01 INFO - '_': '/tools/buildbot/bin/python'} 13:32:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:01 INFO - Downloading/unpacking jsonschema 13:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:32:03 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 13:32:03 INFO - Downloading/unpacking functools32 (from jsonschema) 13:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:03 INFO - Downloading functools32-3.2.3-2.tar.gz 13:32:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:32:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:32:03 INFO - warning: no files found matching '*.txt' 13:32:03 INFO - no previously-included directories found matching 'build' 13:32:03 INFO - no previously-included directories found matching 'dist' 13:32:03 INFO - no previously-included directories found matching '.git*' 13:32:03 INFO - Installing collected packages: jsonschema, functools32 13:32:03 INFO - Running setup.py install for functools32 13:32:03 INFO - warning: no files found matching '*.txt' 13:32:03 INFO - no previously-included directories found matching 'build' 13:32:03 INFO - no previously-included directories found matching 'dist' 13:32:03 INFO - no previously-included directories found matching '.git*' 13:32:03 INFO - Successfully installed jsonschema functools32 13:32:03 INFO - Cleaning up... 13:32:03 INFO - Return code: 0 13:32:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f583e2ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x277e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x284c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28dea50>, '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 0x284a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a9e0>, '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': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', '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 13:32:03 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 13:32:03 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 13:32:03 INFO - Using env: {'DISPLAY': ':0', 13:32:03 INFO - 'HOME': '/home/cltbld', 13:32:03 INFO - 'LANG': 'en_US.UTF-8', 13:32:03 INFO - 'LANGUAGE': 'en_US:en', 13:32:03 INFO - 'LOGNAME': 'cltbld', 13:32:03 INFO - 'MAIL': '/var/mail/cltbld', 13:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:03 INFO - 'MOZ_NO_REMOTE': '1', 13:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:03 INFO - 'NO_EM_RESTART': '1', 13:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:32:03 INFO - 'PWD': '/builds/slave/test-pgo', 13:32:03 INFO - 'SHELL': '/bin/bash', 13:32:03 INFO - 'SHLVL': '1', 13:32:03 INFO - 'TERM': 'linux', 13:32:03 INFO - 'TMOUT': '86400', 13:32:03 INFO - 'USER': 'cltbld', 13:32:03 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', 13:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:03 INFO - '_': '/tools/buildbot/bin/python'} 13:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:03 INFO - Downloading/unpacking flake8 13:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:32:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:32:05 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 13:32:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:32:05 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 13:32:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32:05 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 13:32:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:32:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:32:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:32:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:32:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:32:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:32:06 INFO - no previously-included directories found matching 'docs/_build' 13:32:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:32:06 INFO - Running setup.py install for pep8 13:32:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:32:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:32:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:32:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:32:06 INFO - no previously-included directories found matching 'docs/_build' 13:32:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:32:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:32:06 INFO - Cleaning up... 13:32:06 INFO - Return code: 0 13:32:06 INFO - Running post-action listener: _resource_record_post_action 13:32:06 INFO - Running post-action listener: _start_resource_monitoring 13:32:06 INFO - Starting resource monitoring. 13:32:06 INFO - ##### 13:32:06 INFO - ##### Running install step. 13:32:06 INFO - ##### 13:32:06 INFO - Running pre-action listener: _resource_record_pre_action 13:32:06 INFO - Running main action method: install 13:32:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:32:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:32:06 INFO - Reading from file tmpfile_stdout 13:32:06 INFO - Detecting whether we're running mozinstall >=1.0... 13:32:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:32:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:32:06 INFO - Reading from file tmpfile_stdout 13:32:06 INFO - Output received: 13:32:06 INFO - Usage: mozinstall [options] installer 13:32:06 INFO - Options: 13:32:06 INFO - -h, --help show this help message and exit 13:32:06 INFO - -d DEST, --destination=DEST 13:32:06 INFO - Directory to install application into. [default: 13:32:06 INFO - "/builds/slave/test-pgo"] 13:32:06 INFO - --app=APP Application being installed. [default: firefox] 13:32:06 INFO - mkdir: /builds/slave/test-pgo/build/application 13:32:06 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'] 13:32:06 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 13:32:21 INFO - Reading from file tmpfile_stdout 13:32:21 INFO - Output received: 13:32:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:32:21 INFO - Running post-action listener: _resource_record_post_action 13:32:21 INFO - ##### 13:32:21 INFO - ##### Running run-tests step. 13:32:21 INFO - ##### 13:32:21 INFO - Running pre-action listener: _resource_record_pre_action 13:32:21 INFO - Running main action method: run_tests 13:32:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:32:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:32:21 INFO - Python 2.7.3 13:32:21 INFO - Return code: 0 13:32:21 INFO - grabbing minidump binary from tooltool 13:32:21 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')]} 13:32:21 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 0x28dea50>, '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 0x284a550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x284a9e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:32:21 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 13:32:21 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 13:32:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:32:21 INFO - Return code: 0 13:32:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:32:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:32:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:32:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:32:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:32:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:32:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:32:22 INFO - Return code: 0 13:32:22 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/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 13:32:22 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/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost 13:32:22 INFO - Using env: {'DISPLAY': ':0', 13:32:22 INFO - 'HOME': '/home/cltbld', 13:32:22 INFO - 'LANG': 'en_US.UTF-8', 13:32:22 INFO - 'LANGUAGE': 'en_US:en', 13:32:22 INFO - 'LOGNAME': 'cltbld', 13:32:22 INFO - 'MAIL': '/var/mail/cltbld', 13:32:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:32:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:22 INFO - 'MOZ_NO_REMOTE': '1', 13:32:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:32:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:22 INFO - 'NO_EM_RESTART': '1', 13:32:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:32:22 INFO - 'PWD': '/builds/slave/test-pgo', 13:32:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:32:22 INFO - 'SHELL': '/bin/bash', 13:32:22 INFO - 'SHLVL': '1', 13:32:22 INFO - 'TERM': 'linux', 13:32:22 INFO - 'TMOUT': '86400', 13:32:22 INFO - 'USER': 'cltbld', 13:32:22 INFO - 'XDG_SESSION_COOKIE': 'fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413', 13:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:22 INFO - '_': '/tools/buildbot/bin/python'} 13:32:22 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/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost'] with output_timeout 3600 13:32:22 INFO - mozversion INFO | application_buildid: 20151231110317 13:32:22 INFO - mozversion INFO | application_changeset: c02ba5b2cd2f3f2f9e58f1ff8d5944af3e0adb1c 13:32:22 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 13:32:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:32:22 INFO - mozversion INFO | application_name: Firefox 13:32:22 INFO - mozversion INFO | application_remotingname: firefox-dev 13:32:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:32:22 INFO - mozversion INFO | application_vendor: Mozilla 13:32:22 INFO - mozversion INFO | application_version: 45.0a2 13:32:22 INFO - mozversion INFO | platform_buildid: 20151231110317 13:32:22 INFO - mozversion INFO | platform_changeset: c02ba5b2cd2f3f2f9e58f1ff8d5944af3e0adb1c 13:32:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:32:22 INFO - mozversion INFO | platform_version: 45.0a2 13:32:22 INFO - 2015-12-31 13:32:22,378 DEBUG : using testdate: 1451597542 13:32:22 INFO - 2015-12-31 13:32:22,378 DEBUG : actual date: 1451597542 13:32:22 INFO - 2015-12-31 13:32:22,389 INFO : starting webserver on 'localhost:49304' 13:32:22 INFO - 2015-12-31 13:32:22,390 INFO : Starting test suite talos-linux64-ix-046.e 13:32:22 INFO - 2015-12-31 13:32:22,391 INFO : Starting test dromaeo_css 13:32:22 INFO - 2015-12-31 13:32:22,391 DEBUG : operating with platform_type : linux_ 13:32:22 INFO - 2015-12-31 13:32:22,391 INFO : Initialising browser for dromaeo_css test... 13:32:22 INFO - 2015-12-31 13:32:22,408 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJItrry/profile http://localhost:49304/getInfo.html 13:32:26 INFO - 2015-12-31 13:32:26,567 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:32:26 INFO - 2015-12-31 13:32:26,568 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:32:26 INFO - 2015-12-31 13:32:26,568 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:32:26 INFO - 2015-12-31 13:32:26,568 DEBUG : BROWSER_OUTPUT: __metrics 13:32:27 INFO - 2015-12-31 13:32:27,508 INFO : Browser initialized. 13:32:27 INFO - 2015-12-31 13:32:27,508 INFO : Running cycle 1/1 for dromaeo_css test... 13:32:27 INFO - 2015-12-31 13:32:27,508 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJItrry/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:32:39 INFO - 2015-12-31 13:32:39,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 136966144 13:32:39 INFO - 2015-12-31 13:32:39,252 DEBUG : BROWSER_OUTPUT: 13:33:28 INFO - 2015-12-31 13:33:28,872 DEBUG : BROWSER_OUTPUT: 1451597608871 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] 13:35:36 INFO - 2015-12-31 13:35:36,718 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49304/tests/dromaeo/cssquery-ext.html) 13:35:37 INFO - 2015-12-31 13:35:37,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 140939264 13:35:37 INFO - 2015-12-31 13:35:37,704 DEBUG : BROWSER_OUTPUT: 13:38:39 INFO - 2015-12-31 13:38:39,534 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/dromaeo/cssquery-ext.html (next: http://localhost:49304/tests/dromaeo/cssquery-jquery.html) 13:38:40 INFO - 2015-12-31 13:38:40,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 140603392 13:38:40 INFO - 2015-12-31 13:38:40,120 DEBUG : BROWSER_OUTPUT: 13:41:41 INFO - 2015-12-31 13:41:41,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49304/tests/dromaeo/cssquery-mootools.html) 13:41:42 INFO - 2015-12-31 13:41:42,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 138629120 13:41:42 INFO - 2015-12-31 13:41:42,291 DEBUG : BROWSER_OUTPUT: 13:44:43 INFO - 2015-12-31 13:44:43,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49304/tests/dromaeo/cssquery-prototype.html) 13:44:44 INFO - 2015-12-31 13:44:44,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 139759616 13:44:44 INFO - 2015-12-31 13:44:44,436 DEBUG : BROWSER_OUTPUT: 13:47:46 INFO - 2015-12-31 13:47:46,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49304/tests/dromaeo/cssquery-yui.html) 13:47:47 INFO - 2015-12-31 13:47:47,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 140546048 13:47:47 INFO - 2015-12-31 13:47:47,283 DEBUG : BROWSER_OUTPUT: 13:50:49 INFO - 2015-12-31 13:50:49,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/dromaeo/cssquery-yui.html (next: http://localhost:49304/tests/dromaeo/cssquery-dojo.html) 13:50:49 INFO - 2015-12-31 13:50:49,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 141266944 13:50:49 INFO - 2015-12-31 13:50:49,609 DEBUG : BROWSER_OUTPUT: 13:50:49 INFO - 2015-12-31 13:50:49,611 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:50:49 INFO - 2015-12-31 13:50:49,611 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:50:49 INFO - 2015-12-31 13:50:49,611 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:50:49 INFO - 2015-12-31 13:50:49,611 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:50:49 INFO - 2015-12-31 13:50:49,613 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3326.2848487575175;3376.5441665375183;3390.338883917634;3411.5223868658386;3414.248865249644;5504.366997795255;5509.228707980886;5510.834674959748;5515.310586176728;5518.420565840579;5490.615656904019;5495.120780675093;5504.4770746779095;5530.419305972875;5566.304211973504;5018.322526458927;5045.697258164503;5111.974440127794;5130.384353877521;5144.742762861861;4870.147724148278;4975.975120124394;4976.900461990758;4989.401271847365;5002.524760147799;4966.925496117561;5029.5221953914315;5048.848534543969;5053.772580233898;5146;5096.439391666913;5129.25625784263;5131.640785145023;5145.6398052136365;5171.482851714836;4825.396825396825;4901.191303434929;5038.496150384969;5048.217526283432;5106.974465127651;5247.107991641392;5256.290400795881;5270.57835373173;5286.889753151842;5343.064963631387;5841.0362290222065;5852.326982396994;5885.882282354329;5921.407859214087;5927.496162826165;5610.326760788732;5666.716664166816;5924.614900031527;5926.992411290091;5982.940170598282;5608.943910560883;5612.719364031823;5617.101263797814;5628.409017053233;5633.521150702195;6046.455818976313;6052.394760524;6070.3019152797115;6071.301800293023;6079.148919151322;5613.129964855454;5636.549076073904;5723.055695810144;5868.119782032644;5869.853253668693;5909.468147866627;5965.701714914237;5976.760929562769;5978.760849565969;5985.9401405986255;5899.911501327483;5943;5949.881002380015;5958.493528050078;5967.522598192134;5634.4365563443325;5728.942710572925;5730.140478928194;5761.567882408836;5945.375735547792;4579.038401935631;4597.172508948354;4618.992844445152;4621.745803980746;4637.605803506673;4129.834806607702;4133.483314585676;4137;4143.109231515178;4145.481814773153;5488.094464413327;5512.972435137799;5620.437956204429;5629.071203251499;5761.020626493506;5961.135635332853;5975.492083172979;5997.220361353084;6027.21646185993;6031.758729650853;5686.943130568724;5728.914066289009;5744.454276843693;5748.798792042258;5758.88482230353;4980.327655766498;5025.422076461181;5163.483651634807;5273.288106105703;5319.7340132993195;6135.815925522242;6167.444929956326;6172.259328880473;6176.382361763787;6187.566870319124;5825.679587622722;6015.699215039231;6031;6034.788782392595;6037.15479832815;5992;6054.636721796706;6170.197874276495;6177.938220617916;6186.1648677427975;5894.2926848778425;5920.141579470866;5920.467157955804;5932.8813423732145;5941.31674857397;5710.543156547549;5805.593608447368;6004.0693692477735;6005.429484198994;6031.5476339273855;5696.601237913472;5699.2590963174525;5758.078707406795;5770.682612456355;5802.419758024333;5852.4147585241135;5857.062869940789;5866.765329386777;5875.206847075761;5885.823425297248;5397.082495975615;5492.862678433071;5548.056830338772;5837.912431313449;5846.707664616667;5819.679917604403;5850.678212698343;5897;5901.232839730807;5933.881322373442;5704.0588302929555;5727.942720572908;5738.512226460798;5739.483446489836;5767.567432442667 13:50:49 INFO - 2015-12-31 13:50:49,614 DEBUG : BROWSER_OUTPUT: |1;ext.html;592.055671204429;633.2337871175878;637.716216283754;638.3074364314715;648.9513286503512;32111.839440802793;41450.134743936556;41656.37515437263;41737.791311043475;41927.58072419275;45076.3238551422;45517.31724024134;45765.7711711441;45900.311495327594;45924.08151836961;9036.231920286784;9103.408278461879;9159.35884488086;9197.218236449877;9235.261179105655;8944.284457243437;8964.641414343418;9064.410813297114;9075.092490750938;9080.636774529012;8942.687005954793;9005.964314103896;9044.819103617956;9057.45655260683;9089.727308180765;8879;9041.050689677588;9069.818603627957;9078.319126065506;9109.089091090904;8876.378653494257;8953.641854325884;9042.050584688644;9061.864072038925;9062.093790620951;41625.583744162774;41893.79053104745;42303.788481057396;42529.36205956913;42691.78654106709;3846.519185101862;3925.0776067624083;4197.349410841324;4329.653627709776;4345.978270108661;32054.038378848672;32305.6769432305;32320.353592928244;32360.514592281135;33347.33305333904;3802.429635554689;3896.7077469189926;3906.9609303907164;3970.4242884781543;3974.5826688197612;271183;271193;271488;271706;272217.63891180616;43617;43618;43999.340009899875;44068;44134;41061.794691026356;41432.58567414287;41636.58363416388;41717;41807;15181.696366072616;15358.769618455732;15380.692386152214;15386;15423.460178893685;11129.054030407506;11167.38579378142;11170.776584468427;11297.943510282561;11615.709607259887;14926.626834329229;14943.327550260265;15001.399944002336;15007.099574025593;15039.172845493604;5897.911531327033;6030.6080104793045;6126.08108783686;6155.72299246535;6179;1005.5374527717332;1009.8131845608439;1038.6624347087077;1076.2573824061374;1098.6319582939805;28759.532888465386;28799.280017999718;28905.710942890302;28929.855350723534;29512;1079.8164312066967;1097.237419993113;1116.4417791104447;1176.6293617510457;1222.7065504279087;14916.403343866124;14929.70140597182;14987.70024599502;15011;15291.388344466319;411577;527173;527658;530503;560839;55968.72015639896;57194.42805571891;57294;57574.42425575691;57601.13598296029;1460.123925644626;1463.3561233057421;1464.9487267945783;1475.2771142140275;1489.8882583806042;30686.846565767028;31046.844765776026;31131;31788.205294867814;31827.522587160747;51916;53232.467675322754;53481;53496.465035349145;53679;301796;305318;306192;307044;307835;45269.54730452653;45552.40566580154;45679;46028;46114.538854611026;47349.289760654305;47731.76134119307;48488.27267591059;48517.5148248513;49250.75374623104;41214.21717575641;41472.58527414687;42356.57643423649;43112.56887431211;43424;41130.193130473606;41592.792036039624;41673;41680.58319416767;41788.79105604574;33155;33287.33425331528;33295.33409331848;33360;33390;35823.64176358203;35875;36250.63749362472;36902.44646330361;37187.25625487421;28074.578881317204;28195.71804281931;28199.43601128007;28301.43397132087;28556 13:50:49 INFO - 2015-12-31 13:50:49,618 DEBUG : BROWSER_OUTPUT: |2;jquery.html;385.610533361305;386.8027306073902;389.76224503053135;390.8768737847578;392.8271560513374;15920.124393158372;17300.394486192985;17543.82456175438;18898.527536811587;18972.810271897295;11235.719107022329;11336.093112550976;11564.942175289132;11869.050475961923;11934.04527637789;5007.674501157422;5098.388193416777;5114.181730923053;5125.871853203663;5135.306733590974;4990;5137.101007323722;5302.416734159239;5326.440723724011;5333.759980800854;5213.608979326546;5226.137687281613;5245;5452.91820622691;6116.938830611703;6086.482648974865;6099.085137229429;6120.173776540177;6141.447269745744;6156.984097623887;5376.193570964348;5415.0523658360025;5508.724563771795;5514.172874068881;5529.170624406372;19623.01884905749;20784.48038799027;20831.583368332547;21172.364829055154;21225;2130.989345053265;2155.5904378168098;2178.967315490269;2207.1612787140944;2264.723952427816;10132.94933525335;10328.380297182193;10433.4871443641;10624.309419887682;14472.276386180649;1792.3905872003581;1856.0905156473232;1888.282452667991;1894.4032629721594;1902.781180164285;64267;67768.3223167772;68092;68516.31483685199;69090.65454672695;10687.893121068846;10941;11008.504617292241;11090.722731931766;11099.334039957628;14452.132872027712;14676.192809395372;14684.19236941957;14735.336909839083;14821.110733356034;8002.799930001796;8084.434089613788;8265.049519305358;8280.71017514384;8290.792730181673;8044.396670249755;8049.919500804917;8075.757727268191;8085.312748416451;8188.836223275501;4666.2067448533835;4708.152532544106;4723.433188017391;4733.526647335308;4783.162946484421;1965.7935916728823;1968.0848405491229;1970.753655793026;1982.7125066865513;1990.134291583166;954.3176628710366;967.3470407475066;1005.8591797148405;1006.9194464442827;1034.7257976636197;15233;17403.73894391585;18052.9097354515;18170.727439088423;18791;489.24656029714555;489.7404375680895;495.69762444908577;496.02531026533035;523.8402287302409;6069.575129740876;6095.542834287447;6183.783567575203;6235.875282494416;6247.250329960343;635427;660088;664106;667894;683621;85912.57043714741;85993.57003215069;86569;86908;88443.55778221197;538.1927109335996;538.8868337649137;541.7670401727216;541.983740487786;543.3262754184861;10938.507767150657;11055.336679799238;11074.944625276821;11116.221864469733;11149.609763658233;37490.25019499649;37598.62401375951;37739.62260377471;38091.619083809914;38374;49677.503224968736;49887;49941.25088123754;50109.74945125251;50700.239496406844;9743.782027246594;10160.644377446753;10266.384016959006;10321.071103600712;10480.68557943263;12005.519779208735;17745.378911738026;18484.630307394047;18491.630167396845;18654.44036678902;15511.069335839886;15527.068375897483;15756.212189390713;15864.206789660702;15904.681906361577;15191.468298609496;15493.457728979882;15659.060456372654;15862.44481443144;16198.757018644494;16588.170591470138;16591.41930032443;16718.164091795607;16906.323747050472;17007.744883827;10028.548715307683;10353.275270730977;10385.792284154426;10456.372617642966;10906.727331816768;15950.680986379975;16026.839731602535;16210.837891620933;16285;16383.918080409521 13:50:49 INFO - 2015-12-31 13:50:49,619 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1503.0906301687478;1559.51654986954;1640.3438624550172;1709.546970052936;1810.3935181714126;6452.741890324393;6668.433183179423;7231.493795434321;7578.962105189473;7612.391008719296;7502.88745668814;7719.768406947801;7776.455648104635;7784.494007889483;7798.142204357516;2247.35950254178;2273.727152741665;2294.0365046680436;2298.0233400804673;2302.205739020044;2233.62028455163;2304.020791163757;2314.5833749925005;2315.5368926214824;2319.489712263299;2256.3569382725927;2260.8982595783227;2261.197274967379;2272.704548408713;2315.583195024895;2278.100150440583;2307.9844868257915;2334.731505876829;2334.9182778602753;2336.462613598882;2148.9785102148935;2155.967660485094;2157.8273738100916;2161.5136594266323;2168.8481806273567;7678.577678227695;7720.189380115119;7742.690292388298;7760.146383897767;7769.145394006655;4528.456585209763;4586.862394128181;4619.284010978304;4622.168009758242;4627.791749371287;2868.5697145428144;2940.1326608650284;3002.9549556756447;3006.3987202559574;3013.186439661279;971.1842052675786;996.1283876607968;1017.4658304390255;1022.0903395977585;1028.0541901450608;9802.264830137769;9878.259130565237;9926.851097233548;9949.353292036067;9983.400995940267;4097.97951010249;4126.834926602963;4131.9173616527505;4142.798588409328;4172.624463798273;8682.348823838238;8706.129387061243;8747.343949203836;8750.34372422071;8755.824883502422;4612.3542704021465;4621.09888571732;4651.511591282934;4674.415698037746;4691.038337140878;3665.413533834627;3706.5552133744122;4227.640650544677;4317.654587632982;4321.0709697415205;3655.469956856294;3668.9816550917076;3678.429843374281;3686.893931820443;3705.425659022802;1162.4594563528;1167.3812879174052;1168.4216312925157;1172.4137931034484;1178.4755783676183;1097.533548241994;1116.8938950799661;1120.6694025262568;1400.4258254115764;1465.0550394995169;7188.496805223689;7233.348998590152;7239;7262.673179706926;7277.490575659759;465.176637351892;472.4849913594199;476.5782282679784;480.329939734069;482.7103737757388;5483.506484416342;5500.642458240201;5528;5537.501624853782;5567.415421380778;8750.86873696895;8755.474671519729;9168.679096231599;9361.485118318422;9399.906000939904;9042.276617870555;9070.229030532479;9123.589438475285;9251.398659087137;9319.347645664739;7311.268873112753;7465.888011679721;7485.438592105614;7589.506682065648;7596.430267729832;7292.088488938883;7297.890531641923;7302.050733404623;7324.267573242633;7327.963360183165;8180.8363832721825;8196.057453392936;8260.301791983113;8411.8738218928;8434.156584341517;8188.7952801180445;8221.301189398968;8224.342052635655;8288.751337459886;8311.25198732117;6701.463882889259;6924.4460443165435;7147.928520714726;7256.4194864411775;7292.234315396807;7723.9227607723205;7744.5740484271655;7803.063632364153;7824.647890844812;7856.567888765944;7162.641867906688;7247.275272472711;7303.853922921406;7414.8887766682465;7443.3673137781725;6803.217629972616;6876.656167191521;6920.480963927826;6963.40811031068;7129;7079.8938015930835;7348.30191131863;7364.852702946018;7372.741954031583;7394.667239974106;6697.3637504437;6699.698513566998;6735.49483788708;6745.527813053235;6745.898811517929;6390.584612000205;6401.55189136756;6418.807435776934;6429.453496452854;6582.407583317525 13:50:49 INFO - 2015-12-31 13:50:49,621 DEBUG : BROWSER_OUTPUT: |4;prototype.html;363.2535140286711;364.7100555058729;365.6855104610035;375.1877185892543;378.97347185696975;6239.875202495948;6310.747570097196;6312.652804095778;6369.426751592361;6391.744330226797;6126.2648482182085;6261.279952805428;6270;6285.214348206474;6310.148130002448;4850.345203397549;4853.733044682541;4874.902501949959;4881.3166156738;4895.069936712013;4875.366202393684;4878.2682597610465;4888.902221955576;4891.682040667345;4895.8776030599165;4769.618430525549;4865.48912364202;4874.853754387356;4877.146499362615;4879.219324908016;4839.806407743686;4841.685290456145;4843.24929635907;4855.490173531799;4859.416869975608;4277.101808620194;4298.032942587924;4301.74189548625;4314.899700576364;4323.459567554056;5874.853128671817;5946.5540084493405;5958.731857066399;5963.344032156459;5966.582339236255;5652.265205523297;5674.120511320752;5689.6586204827845;5691.800786972436;5705;6675.399214070709;6681.832954176136;6684.83287917801;6697.162854643169;6711.094002309675;4786.2581299898575;4786.473487916326;4786.976065119652;4787.545183207624;4788.521147885183;6843.863122737567;6897.931020689779;6951.131108611424;6964.651767411659;6982.79051628457;4901.607871370282;4908.042931628298;4908.779104940215;4909.607231421478;4911.943932054625;4975.601951843843;4983.750812459362;4984.327115839315;4987.925181122286;4996.975015124901;5516.3380394352935;5634.690092044895;5644.491995720323;5670.404607516234;5682.119271512922;6739.090222819955;6761.628110453972;6765.830854228585;6772.390484856386;6784.728610855511;1674.4641714651195;1716.7596536484903;1717.2959086774363;1718.2954988454924;1726.894787336106;1141.4806263150247;1147.3517462633586;1152.423788105947;1154.1113342726221;1175.3887978251432;6503.4146926775875;6505.0892874997535;6506.4469520091325;6525.086487891699;6550.967245163743;6878.931210687929;6890.379865812101;6926.930730692729;6932.930670693329;6946.027556142144;6483.286838447767;6491.480681545465;6497.122888410098;6503.28463868974;6524.608523488606;3812.046988252937;3823.5794062653085;3827.808609569566;3838.788866612363;3858.2283543291455;7328.816779580447;7328.973943647894;7333.74331898381;7338.77983660491;7347.448941329421;7157.785266441911;7274.199838017814;7297.087864016998;7297.963510182415;7301.89047164293;7296.16094149169;7317.926820731831;7320.96339518299;7325.4872158948365;7327.45044121693;7072.611006394698;7077.858442831011;7081.256468070778;7087;7090.184628767758;6762.594244345355;6917.27368626287;6953.304669533006;6969.477289203229;6987.7204911802955;7281.526700764433;7289.380402665833;7296.890546641911;7298.306660867209;7305.1233851938105;4728.432588089314;4753.6434767393275;4755.453122890774;4767.880802979815;4768.284757286296;6912.4815638826285;6947.513674042769;7076.964615176891;7079.610621415665;7083.256258093033;6873.140857392826;6880.965595171992;6901.551399159039;6902.309769023058;6915.861682766216;6843.247242803188;6860.176778786378;6873.896891546531;6877.489716253432;6880.346367095118;6618.271990080991;6745.12313399255;6783.253842077466;6786.4910131739325;6807.217170025312;6927.549709269083;6947.930520694728;6948.096747422803;6955.756548520778;6957.304269573002;6707.463402927657;6708.42978346846;6711.664416779239;6712.597244165366;6722.226943901318 13:50:49 INFO - 2015-12-31 13:50:49,621 DEBUG : BROWSER_OUTPUT: |5;yui.html;780.8008957715783;825.5253229393101;841.1672444280165;871.0244526130733;899.9280057595392;13257.602271931833;13408.061435699505;13412.128211666248;13469.326533673326;13479.056466047356;13072.73854522909;13835.308234588256;13858.237796921165;13860.861391386083;13875.514356997508;883.4213590098495;890.6081324217356;906.6962567539882;912.0469109780263;912.0514664748687;908.1327332397577;909.4770506958492;913.2420091324218;915.9267258619294;917.3440989692368;933.351320832022;956.6173530587786;962.1821451766012;962.6438217859367;964.0648570886265;942.886853577575;952.9380590261645;953.5947222430474;955.7276176289758;958.3722661656626;706.791496508526;709;710.8187412209905;711.445072843178;713.6110819603329;13865.37605807731;13923.373448194754;13951.930240348835;14022.43910243589;14023.439062437592;12702.80945785814;12710.745785084338;12771.680707982376;12771.872281277161;13413.597592072254;9903.25725570585;9993.750156246078;10047.949760251226;10216.080552750289;10275;3607.350676878161;3612.843889955215;3675.871344502956;3679.3745063339297;3681.1901381695984;46859.765701171615;47172;47420;47482;48883.51116488825;10097.596096156218;10414.323069000491;10535.473226338652;10578.259521833552;10584.57661693539;17041.31834726597;17071.231794569274;17120.05839678805;17120.229589668244;17140;7950.4832185907735;7971.083325417651;8024.919750802417;8097.109317975136;8190.385721070825;4518.548145185455;4552.908941821145;4718.31584420264;4727.361806156194;4789.784459699322;3149.3228955774616;3179.364127174574;3181.109289398972;3181.427343078268;3185.108169712484;591.1694069831893;591.2461611445442;592.4993380593392;598.850287428143;599.1073300781803;743.115692326141;763.7479631721519;769.7075111457722;774.1832366853024;776.1850057439666;8832.955835220911;8908.153725396207;9118.544072796334;9312.813743725088;9337.673181438753;667.4893706314673;715.5349023135004;740.2079774641082;804.4690504267155;804.8350088231898;4442.53353397895;4548.636109111263;4592.494825569184;4657.534246575316;4726.787294571753;55985;56299.43700562942;56711.43288567144;57000.00499982481;57144.428555714745;48803.02393952101;53019.734901325246;53505;53738.731306344;53783.19325210125;47380.52619473761;47724;48213.27680084801;48444.515554844;48904.99999999929;9578.760530986781;9847.409155450696;9880.50597470138;9974.351667141613;10023.097921187129;34855.65144348524;34935.95990185406;35186.824065879504;35348.293034139686;35784.105397364234;44220;46740.7662961683;47117;47129.2930606048;47280.52719472761;11405.771884562097;11710.238834475731;11823.467943942715;11872.46573904159;12090.335031572997;13160.078794484294;13229.669258268621;13277;13618.250996195304;13731.244781536712;11955.521779128738;12313.13808033465;12469.625911222678;12676.23942563449;12740.490380384681;11808.527658893549;11814.881851181379;11878.465469054086;11906.821397678868;12320.199187052813;10443.738906527095;11873.406329683654;12367.196132251374;12660.746785064432;12914.741705166032;10367.740806479596;10621.203409744454;10671.733206669585;10754.032137107697;10903.836442453528;10132.138768204784;10584;10618.150547955991;10678.8932110681;10697.358158510515 13:50:49 INFO - 2015-12-31 13:50:49,621 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:50:49 INFO - 2015-12-31 13:50:49,621 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:50:49 INFO - 2015-12-31 13:50:49,621 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,298 13:50:49 INFO - 2015-12-31 13:50:49,621 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:50:49 INFO - 2015-12-31 13:50:49,621 DEBUG : BROWSER_OUTPUT: __startTimestamp1451598649609__endTimestamp 13:50:49 INFO - 2015-12-31 13:50:49,621 DEBUG : BROWSER_OUTPUT: 13:50:49 INFO - 2015-12-31 13:50:49,621 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:50:49 INFO - 2015-12-31 13:50:49,621 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:50:49 INFO - 2015-12-31 13:50:49,622 DEBUG : BROWSER_OUTPUT: 13:50:49 INFO - 2015-12-31 13:50:49,622 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5512.46 Median:5723.06 stddev:599.17 (10.5%) stddev-sans-first:575.94 13:50:49 INFO - 2015-12-31 13:50:49,623 DEBUG : BROWSER_OUTPUT: Values: 3326.3 3376.5 3390.3 3411.5 3414.2 5504.4 5509.2 5510.8 5515.3 5518.4 5490.6 5495.1 5504.5 5530.4 5566.3 5018.3 5045.7 5112.0 5130.4 5144.7 4870.1 4976.0 4976.9 4989.4 5002.5 4966.9 5029.5 5048.8 5053.8 5146.0 5096.4 5129.3 5131.6 5145.6 5171.5 4825.4 4901.2 5038.5 5048.2 5107.0 5247.1 5256.3 5270.6 5286.9 5343.1 5841.0 5852.3 5885.9 5921.4 5927.5 5610.3 5666.7 5924.6 5927.0 5982.9 5608.9 5612.7 5617.1 5628.4 5633.5 6046.5 6052.4 6070.3 6071.3 6079.1 5613.1 5636.5 5723.1 5868.1 5869.9 5909.5 5965.7 5976.8 5978.8 5985.9 5899.9 5943.0 5949.9 5958.5 5967.5 5634.4 5728.9 5730.1 5761.6 5945.4 4579.0 4597.2 4619.0 4621.7 4637.6 4129.8 4133.5 4137.0 4143.1 4145.5 5488.1 5513.0 5620.4 5629.1 5761.0 5961.1 5975.5 5997.2 6027.2 6031.8 5686.9 5728.9 5744.5 5748.8 5758.9 4980.3 5025.4 5163.5 5273.3 5319.7 6135.8 6167.4 6172.3 6176.4 6187.6 5825.7 6015.7 6031.0 6034.8 6037.2 5992.0 6054.6 6170.2 6177.9 6186.2 5894.3 5920.1 5920.5 5932.9 5941.3 5710.5 5805.6 6004.1 6005.4 6031.5 5696.6 5699.3 5758.1 5770.7 5802.4 5852.4 5857.1 5866.8 5875.2 5885.8 5397.1 5492.9 5548.1 5837.9 5846.7 5819.7 5850.7 5897.0 5901.2 5933.9 5704.1 5727.9 5738.5 5739.5 5767.6 13:50:49 INFO - 2015-12-31 13:50:49,623 DEBUG : BROWSER_OUTPUT: 13:50:49 INFO - 2015-12-31 13:50:49,623 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:52804.27 Median:41609.19 stddev:100511.68 (241.6%) stddev-sans-first:100717.20 13:50:49 INFO - 2015-12-31 13:50:49,623 DEBUG : BROWSER_OUTPUT: Values: 592.1 633.2 637.7 638.3 649.0 32111.8 41450.1 41656.4 41737.8 41927.6 45076.3 45517.3 45765.8 45900.3 45924.1 9036.2 9103.4 9159.4 9197.2 9235.3 8944.3 8964.6 9064.4 9075.1 9080.6 8942.7 9006.0 9044.8 9057.5 9089.7 8879.0 9041.1 9069.8 9078.3 9109.1 8876.4 8953.6 9042.1 9061.9 9062.1 41625.6 41893.8 42303.8 42529.4 42691.8 3846.5 3925.1 4197.3 4329.7 4346.0 32054.0 32305.7 32320.4 32360.5 33347.3 3802.4 3896.7 3907.0 3970.4 3974.6 271183.0 271193.0 271488.0 271706.0 272217.6 43617.0 43618.0 43999.3 44068.0 44134.0 41061.8 41432.6 41636.6 41717.0 41807.0 15181.7 15358.8 15380.7 15386.0 15423.5 11129.1 11167.4 11170.8 11297.9 11615.7 14926.6 14943.3 15001.4 15007.1 15039.2 5897.9 6030.6 6126.1 6155.7 6179.0 1005.5 1009.8 1038.7 1076.3 1098.6 28759.5 28799.3 28905.7 28929.9 29512.0 1079.8 1097.2 1116.4 1176.6 1222.7 14916.4 14929.7 14987.7 15011.0 15291.4 411577.0 527173.0 527658.0 530503.0 560839.0 55968.7 57194.4 57294.0 57574.4 57601.1 1460.1 1463.4 1464.9 1475.3 1489.9 30686.8 31046.8 31131.0 31788.2 31827.5 51916.0 53232.5 53481.0 53496.5 53679.0 301796.0 305318.0 306192.0 307044.0 307835.0 45269.5 45552.4 45679.0 46028.0 46114.5 47349.3 47731.8 48488.3 48517.5 49250.8 41214.2 41472.6 42356.6 43112.6 43424.0 41130.2 41592.8 41673.0 41680.6 41788.8 33155.0 33287.3 33295.3 33360.0 33390.0 35823.6 35875.0 36250.6 36902.4 37187.3 28074.6 28195.7 28199.4 28301.4 28556.0 13:50:49 INFO - 2015-12-31 13:50:49,623 DEBUG : BROWSER_OUTPUT: 13:50:49 INFO - 2015-12-31 13:50:49,624 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32914.81 Median:2235.94 stddev:108249.00 (4841.3%) stddev-sans-first:108525.11 13:50:49 INFO - 2015-12-31 13:50:49,624 DEBUG : BROWSER_OUTPUT: Values: 385.6 386.8 389.8 390.9 392.8 15920.1 17300.4 17543.8 18898.5 18972.8 11235.7 11336.1 11564.9 11869.1 11934.0 5007.7 5098.4 5114.2 5125.9 5135.3 4990.0 5137.1 5302.4 5326.4 5333.8 5213.6 5226.1 5245.0 5452.9 6116.9 6086.5 6099.1 6120.2 6141.4 6157.0 5376.2 5415.1 5508.7 5514.2 5529.2 19623.0 20784.5 20831.6 21172.4 21225.0 2131.0 2155.6 2179.0 2207.2 2264.7 10132.9 10328.4 10433.5 10624.3 14472.3 1792.4 1856.1 1888.3 1894.4 1902.8 64267.0 67768.3 68092.0 68516.3 69090.7 10687.9 10941.0 11008.5 11090.7 11099.3 14452.1 14676.2 14684.2 14735.3 14821.1 8002.8 8084.4 8265.0 8280.7 8290.8 8044.4 8049.9 8075.8 8085.3 8188.8 4666.2 4708.2 4723.4 4733.5 4783.2 1965.8 1968.1 1970.8 1982.7 1990.1 954.3 967.3 1005.9 1006.9 1034.7 15233.0 17403.7 18052.9 18170.7 18791.0 489.2 489.7 495.7 496.0 523.8 6069.6 6095.5 6183.8 6235.9 6247.3 635427.0 660088.0 664106.0 667894.0 683621.0 85912.6 85993.6 86569.0 86908.0 88443.6 538.2 538.9 541.8 542.0 543.3 10938.5 11055.3 11074.9 11116.2 11149.6 37490.3 37598.6 37739.6 38091.6 38374.0 49677.5 49887.0 49941.3 50109.7 50700.2 9743.8 10160.6 10266.4 10321.1 10480.7 12005.5 17745.4 18484.6 18491.6 18654.4 15511.1 15527.1 15756.2 15864.2 15904.7 15191.5 15493.5 15659.1 15862.4 16198.8 16588.2 16591.4 16718.2 16906.3 17007.7 10028.5 10353.3 10385.8 10456.4 10906.7 15950.7 16026.8 16210.8 16285.0 16383.9 13:50:49 INFO - 2015-12-31 13:50:49,624 DEBUG : BROWSER_OUTPUT: 13:50:49 INFO - 2015-12-31 13:50:49,624 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5391.16 Median:6698.53 stddev:2786.06 (41.6%) stddev-sans-first:2778.55 13:50:49 INFO - 2015-12-31 13:50:49,625 DEBUG : BROWSER_OUTPUT: Values: 1503.1 1559.5 1640.3 1709.5 1810.4 6452.7 6668.4 7231.5 7579.0 7612.4 7502.9 7719.8 7776.5 7784.5 7798.1 2247.4 2273.7 2294.0 2298.0 2302.2 2233.6 2304.0 2314.6 2315.5 2319.5 2256.4 2260.9 2261.2 2272.7 2315.6 2278.1 2308.0 2334.7 2334.9 2336.5 2149.0 2156.0 2157.8 2161.5 2168.8 7678.6 7720.2 7742.7 7760.1 7769.1 4528.5 4586.9 4619.3 4622.2 4627.8 2868.6 2940.1 3003.0 3006.4 3013.2 971.2 996.1 1017.5 1022.1 1028.1 9802.3 9878.3 9926.9 9949.4 9983.4 4098.0 4126.8 4131.9 4142.8 4172.6 8682.3 8706.1 8747.3 8750.3 8755.8 4612.4 4621.1 4651.5 4674.4 4691.0 3665.4 3706.6 4227.6 4317.7 4321.1 3655.5 3669.0 3678.4 3686.9 3705.4 1162.5 1167.4 1168.4 1172.4 1178.5 1097.5 1116.9 1120.7 1400.4 1465.1 7188.5 7233.3 7239.0 7262.7 7277.5 465.2 472.5 476.6 480.3 482.7 5483.5 5500.6 5528.0 5537.5 5567.4 8750.9 8755.5 9168.7 9361.5 9399.9 9042.3 9070.2 9123.6 9251.4 9319.3 7311.3 7465.9 7485.4 7589.5 7596.4 7292.1 7297.9 7302.1 7324.3 7328.0 8180.8 8196.1 8260.3 8411.9 8434.2 8188.8 8221.3 8224.3 8288.8 8311.3 6701.5 6924.4 7147.9 7256.4 7292.2 7723.9 7744.6 7803.1 7824.6 7856.6 7162.6 7247.3 7303.9 7414.9 7443.4 6803.2 6876.7 6920.5 6963.4 7129.0 7079.9 7348.3 7364.9 7372.7 7394.7 6697.4 6699.7 6735.5 6745.5 6745.9 6390.6 6401.6 6418.8 6429.5 6582.4 13:50:49 INFO - 2015-12-31 13:50:49,626 DEBUG : BROWSER_OUTPUT: 13:50:49 INFO - 2015-12-31 13:50:49,626 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5689.22 Median:6487.38 stddev:1714.06 (26.4%) stddev-sans-first:1671.60 13:50:49 INFO - 2015-12-31 13:50:49,626 DEBUG : BROWSER_OUTPUT: Values: 363.3 364.7 365.7 375.2 379.0 6239.9 6310.7 6312.7 6369.4 6391.7 6126.3 6261.3 6270.0 6285.2 6310.1 4850.3 4853.7 4874.9 4881.3 4895.1 4875.4 4878.3 4888.9 4891.7 4895.9 4769.6 4865.5 4874.9 4877.1 4879.2 4839.8 4841.7 4843.2 4855.5 4859.4 4277.1 4298.0 4301.7 4314.9 4323.5 5874.9 5946.6 5958.7 5963.3 5966.6 5652.3 5674.1 5689.7 5691.8 5705.0 6675.4 6681.8 6684.8 6697.2 6711.1 4786.3 4786.5 4787.0 4787.5 4788.5 6843.9 6897.9 6951.1 6964.7 6982.8 4901.6 4908.0 4908.8 4909.6 4911.9 4975.6 4983.8 4984.3 4987.9 4997.0 5516.3 5634.7 5644.5 5670.4 5682.1 6739.1 6761.6 6765.8 6772.4 6784.7 1674.5 1716.8 1717.3 1718.3 1726.9 1141.5 1147.4 1152.4 1154.1 1175.4 6503.4 6505.1 6506.4 6525.1 6551.0 6878.9 6890.4 6926.9 6932.9 6946.0 6483.3 6491.5 6497.1 6503.3 6524.6 3812.0 3823.6 3827.8 3838.8 3858.2 7328.8 7329.0 7333.7 7338.8 7347.4 7157.8 7274.2 7297.1 7298.0 7301.9 7296.2 7317.9 7321.0 7325.5 7327.5 7072.6 7077.9 7081.3 7087.0 7090.2 6762.6 6917.3 6953.3 6969.5 6987.7 7281.5 7289.4 7296.9 7298.3 7305.1 4728.4 4753.6 4755.5 4767.9 4768.3 6912.5 6947.5 7077.0 7079.6 7083.3 6873.1 6881.0 6901.6 6902.3 6915.9 6843.2 6860.2 6873.9 6877.5 6880.3 6618.3 6745.1 6783.3 6786.5 6807.2 6927.5 6947.9 6948.1 6955.8 6957.3 6707.5 6708.4 6711.7 6712.6 6722.2 13:50:49 INFO - 2015-12-31 13:50:49,626 DEBUG : BROWSER_OUTPUT: 13:50:49 INFO - 2015-12-31 13:50:49,626 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14207.55 Median:25699.15 stddev:16054.06 (62.5%) stddev-sans-first:16067.43 13:50:49 INFO - 2015-12-31 13:50:49,626 DEBUG : BROWSER_OUTPUT: Values: 780.8 825.5 841.2 871.0 899.9 13257.6 13408.1 13412.1 13469.3 13479.1 13072.7 13835.3 13858.2 13860.9 13875.5 883.4 890.6 906.7 912.0 912.1 908.1 909.5 913.2 915.9 917.3 933.4 956.6 962.2 962.6 964.1 942.9 952.9 953.6 955.7 958.4 706.8 709.0 710.8 711.4 713.6 13865.4 13923.4 13951.9 14022.4 14023.4 12702.8 12710.7 12771.7 12771.9 13413.6 9903.3 9993.8 10047.9 10216.1 10275.0 3607.4 3612.8 3675.9 3679.4 3681.2 46859.8 47172.0 47420.0 47482.0 48883.5 10097.6 10414.3 10535.5 10578.3 10584.6 17041.3 17071.2 17120.1 17120.2 17140.0 7950.5 7971.1 8024.9 8097.1 8190.4 4518.5 4552.9 4718.3 4727.4 4789.8 3149.3 3179.4 3181.1 3181.4 3185.1 591.2 591.2 592.5 598.9 599.1 743.1 763.7 769.7 774.2 776.2 8833.0 8908.2 9118.5 9312.8 9337.7 667.5 715.5 740.2 804.5 804.8 4442.5 4548.6 4592.5 4657.5 4726.8 55985.0 56299.4 56711.4 57000.0 57144.4 48803.0 53019.7 53505.0 53738.7 53783.2 47380.5 47724.0 48213.3 48444.5 48905.0 9578.8 9847.4 9880.5 9974.4 10023.1 34855.7 34936.0 35186.8 35348.3 35784.1 44220.0 46740.8 47117.0 47129.3 47280.5 11405.8 11710.2 11823.5 11872.5 12090.3 13160.1 13229.7 13277.0 13618.3 13731.2 11955.5 12313.1 12469.6 12676.2 12740.5 11808.5 11814.9 11878.5 11906.8 12320.2 10443.7 11873.4 12367.2 12660.7 12914.7 10367.7 10621.2 10671.7 10754.0 10903.8 10132.1 10584.0 10618.2 10678.9 10697.4 13:50:49 INFO - 2015-12-31 13:50:49,626 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:50:49 INFO - 2015-12-31 13:50:49,626 DEBUG : BROWSER_OUTPUT: 13:50:50 INFO - 2015-12-31 13:50:50,268 INFO : Browser exited with error code: 0 13:50:50 INFO - 2015-12-31 13:50:50,286 INFO : Completed test dromaeo_css (00:18:27) 13:50:50 INFO - 2015-12-31 13:50:50,287 INFO : Starting test kraken 13:50:50 INFO - 2015-12-31 13:50:50,287 DEBUG : operating with platform_type : linux_ 13:50:50 INFO - 2015-12-31 13:50:50,287 INFO : Initialising browser for kraken test... 13:50:50 INFO - 2015-12-31 13:50:50,293 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpU8CqI5/profile http://localhost:49304/getInfo.html 13:50:54 INFO - 2015-12-31 13:50:54,500 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:50:54 INFO - 2015-12-31 13:50:54,500 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:50:54 INFO - 2015-12-31 13:50:54,500 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:50:54 INFO - 2015-12-31 13:50:54,500 DEBUG : BROWSER_OUTPUT: __metrics 13:50:55 INFO - 2015-12-31 13:50:55,444 INFO : Browser initialized. 13:50:55 INFO - 2015-12-31 13:50:55,444 INFO : Running cycle 1/1 for kraken test... 13:50:55 INFO - 2015-12-31 13:50:55,444 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpU8CqI5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:51:07 INFO - 2015-12-31 13:51:07,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 136855552 13:51:07 INFO - 2015-12-31 13:51:07,208 DEBUG : BROWSER_OUTPUT: 13:51:09 INFO - 2015-12-31 13:51:09,665 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49304/tests/kraken/driver.html?testName=audio-beat-detection) 13:51:10 INFO - 2015-12-31 13:51:10,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 137814016 13:51:10 INFO - 2015-12-31 13:51:10,268 DEBUG : BROWSER_OUTPUT: 13:51:12 INFO - 2015-12-31 13:51:12,846 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49304/tests/kraken/driver.html?testName=audio-dft) 13:51:13 INFO - 2015-12-31 13:51:13,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 138272768 13:51:13 INFO - 2015-12-31 13:51:13,433 DEBUG : BROWSER_OUTPUT: 13:51:16 INFO - 2015-12-31 13:51:16,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49304/tests/kraken/driver.html?testName=audio-fft) 13:51:16 INFO - 2015-12-31 13:51:16,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 138334208 13:51:16 INFO - 2015-12-31 13:51:16,819 DEBUG : BROWSER_OUTPUT: 13:51:18 INFO - 2015-12-31 13:51:18,820 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49304/tests/kraken/driver.html?testName=audio-oscillator) 13:51:19 INFO - 2015-12-31 13:51:19,407 DEBUG : BROWSER_OUTPUT: RSS: Main: 138072064 13:51:19 INFO - 2015-12-31 13:51:19,407 DEBUG : BROWSER_OUTPUT: 13:51:21 INFO - 2015-12-31 13:51:21,614 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49304/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:51:22 INFO - 2015-12-31 13:51:22,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 138297344 13:51:22 INFO - 2015-12-31 13:51:22,188 DEBUG : BROWSER_OUTPUT: 13:51:25 INFO - 2015-12-31 13:51:25,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49304/tests/kraken/driver.html?testName=imaging-darkroom) 13:51:25 INFO - 2015-12-31 13:51:25,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 139407360 13:51:25 INFO - 2015-12-31 13:51:25,694 DEBUG : BROWSER_OUTPUT: 13:51:29 INFO - 2015-12-31 13:51:29,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49304/tests/kraken/driver.html?testName=imaging-desaturate) 13:51:29 INFO - 2015-12-31 13:51:29,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 139108352 13:51:29 INFO - 2015-12-31 13:51:29,607 DEBUG : BROWSER_OUTPUT: 13:51:32 INFO - 2015-12-31 13:51:32,397 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49304/tests/kraken/driver.html?testName=json-parse-financial) 13:51:32 INFO - 2015-12-31 13:51:32,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 139239424 13:51:32 INFO - 2015-12-31 13:51:32,988 DEBUG : BROWSER_OUTPUT: 13:51:34 INFO - 2015-12-31 13:51:34,577 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49304/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:51:35 INFO - 2015-12-31 13:51:35,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 137236480 13:51:35 INFO - 2015-12-31 13:51:35,147 DEBUG : BROWSER_OUTPUT: 13:51:36 INFO - 2015-12-31 13:51:36,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49304/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:51:37 INFO - 2015-12-31 13:51:37,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 137805824 13:51:37 INFO - 2015-12-31 13:51:37,512 DEBUG : BROWSER_OUTPUT: 13:51:39 INFO - 2015-12-31 13:51:39,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49304/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:51:40 INFO - 2015-12-31 13:51:40,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 137994240 13:51:40 INFO - 2015-12-31 13:51:40,131 DEBUG : BROWSER_OUTPUT: 13:51:42 INFO - 2015-12-31 13:51:42,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:51:43 INFO - 2015-12-31 13:51:43,143 DEBUG : BROWSER_OUTPUT: RSS: Main: 138510336 13:51:43 INFO - 2015-12-31 13:51:43,143 DEBUG : BROWSER_OUTPUT: 13:51:45 INFO - 2015-12-31 13:51:45,699 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:51:46 INFO - 2015-12-31 13:51:46,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 139968512 13:51:46 INFO - 2015-12-31 13:51:46,293 DEBUG : BROWSER_OUTPUT: 13:51:47 INFO - 2015-12-31 13:51:47,948 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49304/tests/kraken/driver.html?testName=ai-astar) 13:51:48 INFO - 2015-12-31 13:51:48,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 138981376 13:51:48 INFO - 2015-12-31 13:51:48,198 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-31 13:51:48,199 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:51:48 INFO - 2015-12-31 13:51:48,199 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:51:48 INFO - 2015-12-31 13:51:48,199 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:51:48 INFO - 2015-12-31 13:51:48,200 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:51:48 INFO - 2015-12-31 13:51:48,200 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;107;111;110;112;129;111;110;111;111 13:51:48 INFO - 2015-12-31 13:51:48,200 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;129;151;165;123;151;148;123;156;125 13:51:48 INFO - 2015-12-31 13:51:48,200 DEBUG : BROWSER_OUTPUT: |2;audio-dft;165;163;161;162;162;162;160;162;163;167 13:51:48 INFO - 2015-12-31 13:51:48,200 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;74;77;155;73;74;71;74;153;73 13:51:48 INFO - 2015-12-31 13:51:48,201 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;148;92;92;92;136;92;94;144 13:51:48 INFO - 2015-12-31 13:51:48,201 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;110;110;110 13:51:48 INFO - 2015-12-31 13:51:48,201 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;148;147;147;147;147;147;148;146 13:51:48 INFO - 2015-12-31 13:51:48,201 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;97;97;96;95;97;96;96 13:51:48 INFO - 2015-12-31 13:51:48,201 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;62;63;62;58;59;59;59;61;59;61 13:51:48 INFO - 2015-12-31 13:51:48,201 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;63;64;64;63;64;64;64;64 13:51:48 INFO - 2015-12-31 13:51:48,202 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;80;84;82;81;81;82;81;89;81 13:51:48 INFO - 2015-12-31 13:51:48,202 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;116;124;117;115;119;119;125;129;112 13:51:48 INFO - 2015-12-31 13:51:48,202 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;149;151;149;150;145;151;149;149;146 13:51:48 INFO - 2015-12-31 13:51:48,202 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;66;66;67;69;66;68;67;66;66 13:51:48 INFO - 2015-12-31 13:51:48,202 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:51:48 INFO - 2015-12-31 13:51:48,202 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:51:48 INFO - 2015-12-31 13:51:48,202 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,717 13:51:48 INFO - 2015-12-31 13:51:48,202 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:51:48 INFO - 2015-12-31 13:51:48,203 DEBUG : BROWSER_OUTPUT: __startTimestamp1451598708198__endTimestamp 13:51:48 INFO - 2015-12-31 13:51:48,203 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-31 13:51:48,206 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:51:48 INFO - 2015-12-31 13:51:48,206 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:51:48 INFO - 2015-12-31 13:51:48,206 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-31 13:51:48,206 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.50 Median:111.00 stddev:6.00 (5.4%) stddev-sans-first:6.37 13:51:48 INFO - 2015-12-31 13:51:48,206 DEBUG : BROWSER_OUTPUT: Values: 113.0 107.0 111.0 110.0 112.0 129.0 111.0 110.0 111.0 111.0 13:51:48 INFO - 2015-12-31 13:51:48,207 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-31 13:51:48,207 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:142.10 Median:150.50 stddev:15.52 (10.3%) stddev-sans-first:16.19 13:51:48 INFO - 2015-12-31 13:51:48,207 DEBUG : BROWSER_OUTPUT: Values: 150.0 129.0 151.0 165.0 123.0 151.0 148.0 123.0 156.0 125.0 13:51:48 INFO - 2015-12-31 13:51:48,207 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-31 13:51:48,207 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:2.00 (1.2%) stddev-sans-first:1.94 13:51:48 INFO - 2015-12-31 13:51:48,207 DEBUG : BROWSER_OUTPUT: Values: 165.0 163.0 161.0 162.0 162.0 162.0 160.0 162.0 163.0 167.0 13:51:48 INFO - 2015-12-31 13:51:48,207 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-31 13:51:48,208 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.20 Median:74.00 stddev:33.69 (45.5%) stddev-sans-first:35.44 13:51:48 INFO - 2015-12-31 13:51:48,208 DEBUG : BROWSER_OUTPUT: Values: 78.0 74.0 77.0 155.0 73.0 74.0 71.0 74.0 153.0 73.0 13:51:48 INFO - 2015-12-31 13:51:48,208 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-31 13:51:48,208 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.60 Median:92.00 stddev:24.38 (26.5%) stddev-sans-first:25.28 13:51:48 INFO - 2015-12-31 13:51:48,208 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 148.0 92.0 92.0 92.0 136.0 92.0 94.0 144.0 13:51:48 INFO - 2015-12-31 13:51:48,208 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-31 13:51:48,208 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 13:51:48 INFO - 2015-12-31 13:51:48,209 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 110.0 13:51:48 INFO - 2015-12-31 13:51:48,209 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-31 13:51:48,209 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 13:51:48 INFO - 2015-12-31 13:51:48,209 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 148.0 147.0 147.0 147.0 147.0 147.0 148.0 146.0 13:51:48 INFO - 2015-12-31 13:51:48,210 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-31 13:51:48,210 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 13:51:48 INFO - 2015-12-31 13:51:48,210 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 97.0 97.0 96.0 95.0 97.0 96.0 96.0 13:51:48 INFO - 2015-12-31 13:51:48,210 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-31 13:51:48,210 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.30 Median:61.00 stddev:1.70 (2.8%) stddev-sans-first:1.69 13:51:48 INFO - 2015-12-31 13:51:48,210 DEBUG : BROWSER_OUTPUT: Values: 62.0 63.0 62.0 58.0 59.0 59.0 59.0 61.0 59.0 61.0 13:51:48 INFO - 2015-12-31 13:51:48,211 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-31 13:51:48,211 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 13:51:48 INFO - 2015-12-31 13:51:48,211 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 63.0 64.0 64.0 63.0 64.0 64.0 64.0 64.0 13:51:48 INFO - 2015-12-31 13:51:48,211 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-31 13:51:48,211 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:2.58 (3.2%) stddev-sans-first:2.74 13:51:48 INFO - 2015-12-31 13:51:48,211 DEBUG : BROWSER_OUTPUT: Values: 82.0 80.0 84.0 82.0 81.0 81.0 82.0 81.0 89.0 81.0 13:51:48 INFO - 2015-12-31 13:51:48,211 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-31 13:51:48,212 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.20 Median:119.00 stddev:5.25 (4.4%) stddev-sans-first:5.43 13:51:48 INFO - 2015-12-31 13:51:48,212 DEBUG : BROWSER_OUTPUT: Values: 116.0 116.0 124.0 117.0 115.0 119.0 119.0 125.0 129.0 112.0 13:51:48 INFO - 2015-12-31 13:51:48,212 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-31 13:51:48,212 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.50 Median:149.00 stddev:4.48 (3.0%) stddev-sans-first:2.05 13:51:48 INFO - 2015-12-31 13:51:48,212 DEBUG : BROWSER_OUTPUT: Values: 136.0 149.0 151.0 149.0 150.0 145.0 151.0 149.0 149.0 146.0 13:51:48 INFO - 2015-12-31 13:51:48,212 DEBUG : BROWSER_OUTPUT: 13:51:48 INFO - 2015-12-31 13:51:48,212 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.25 (1.9%) stddev-sans-first:1.09 13:51:48 INFO - 2015-12-31 13:51:48,212 DEBUG : BROWSER_OUTPUT: Values: 69.0 66.0 66.0 67.0 69.0 66.0 68.0 67.0 66.0 66.0 13:51:48 INFO - 2015-12-31 13:51:48,213 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:51:48 INFO - 2015-12-31 13:51:48,213 DEBUG : BROWSER_OUTPUT: 13:51:49 INFO - 2015-12-31 13:51:49,052 INFO : Browser exited with error code: 0 13:51:49 INFO - 2015-12-31 13:51:49,107 INFO : Completed test kraken (00:00:58) 13:51:49 INFO - 2015-12-31 13:51:49,107 INFO : Starting test v8_7 13:51:49 INFO - 2015-12-31 13:51:49,107 DEBUG : operating with platform_type : linux_ 13:51:49 INFO - 2015-12-31 13:51:49,107 INFO : Initialising browser for v8_7 test... 13:51:49 INFO - 2015-12-31 13:51:49,113 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKiIFpO/profile http://localhost:49304/getInfo.html 13:51:53 INFO - 2015-12-31 13:51:53,315 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:51:53 INFO - 2015-12-31 13:51:53,315 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:51:53 INFO - 2015-12-31 13:51:53,315 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:51:53 INFO - 2015-12-31 13:51:53,315 DEBUG : BROWSER_OUTPUT: __metrics 13:51:54 INFO - 2015-12-31 13:51:54,256 INFO : Browser initialized. 13:51:54 INFO - 2015-12-31 13:51:54,256 INFO : Running cycle 1/1 for v8_7 test... 13:51:54 INFO - 2015-12-31 13:51:54,256 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpKiIFpO/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:52:06 INFO - 2015-12-31 13:52:06,119 DEBUG : BROWSER_OUTPUT: RSS: Main: 136585216 13:52:06 INFO - 2015-12-31 13:52:06,120 DEBUG : BROWSER_OUTPUT: 13:52:27 INFO - 2015-12-31 13:52:27,467 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49304/tests/v8_7/run.html (next: http://localhost:49304/tests/v8_7/run.html) 13:52:27 INFO - 2015-12-31 13:52:27,718 DEBUG : BROWSER_OUTPUT: RSS: Main: 136187904 13:52:27 INFO - 2015-12-31 13:52:27,718 DEBUG : BROWSER_OUTPUT: 13:52:27 INFO - 2015-12-31 13:52:27,718 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:52:27 INFO - 2015-12-31 13:52:27,718 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:52:27 INFO - 2015-12-31 13:52:27,718 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:52:27 INFO - 2015-12-31 13:52:27,719 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:52:27 INFO - 2015-12-31 13:52:27,719 DEBUG : BROWSER_OUTPUT: |0;Richards;164.2845408247084 13:52:27 INFO - 2015-12-31 13:52:27,719 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.9727834362999 13:52:27 INFO - 2015-12-31 13:52:27,719 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.9400278940028 13:52:27 INFO - 2015-12-31 13:52:27,719 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5159.79381443299 13:52:27 INFO - 2015-12-31 13:52:27,720 DEBUG : BROWSER_OUTPUT: |4;RayTrace;925.0693802035153 13:52:27 INFO - 2015-12-31 13:52:27,720 DEBUG : BROWSER_OUTPUT: |5;Earley;549.4505494505495 13:52:27 INFO - 2015-12-31 13:52:27,720 DEBUG : BROWSER_OUTPUT: |6;Boyer;10784.946236559139 13:52:27 INFO - 2015-12-31 13:52:27,720 DEBUG : BROWSER_OUTPUT: |7;RegExp;25150 13:52:27 INFO - 2015-12-31 13:52:27,720 DEBUG : BROWSER_OUTPUT: |8;Splay;514.6529562982005 13:52:27 INFO - 2015-12-31 13:52:27,720 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 13:52:27 INFO - 2015-12-31 13:52:27,720 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:52:27 INFO - 2015-12-31 13:52:27,720 DEBUG : BROWSER_OUTPUT: __startTimestamp1451598747716__endTimestamp 13:52:27 INFO - 2015-12-31 13:52:27,720 DEBUG : BROWSER_OUTPUT: 13:52:27 INFO - 2015-12-31 13:52:27,721 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:52:27 INFO - 2015-12-31 13:52:27,721 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:52:27 INFO - 2015-12-31 13:52:27,721 DEBUG : BROWSER_OUTPUT: 13:52:27 INFO - 2015-12-31 13:52:27,721 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.28 Median:164.28 stddev:0.00 (0.0%) 13:52:27 INFO - 2015-12-31 13:52:27,721 DEBUG : BROWSER_OUTPUT: Values: 164.3 13:52:27 INFO - 2015-12-31 13:52:27,721 DEBUG : BROWSER_OUTPUT: 13:52:27 INFO - 2015-12-31 13:52:27,721 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.97 Median:166.97 stddev:0.00 (0.0%) 13:52:27 INFO - 2015-12-31 13:52:27,722 DEBUG : BROWSER_OUTPUT: Values: 167.0 13:52:27 INFO - 2015-12-31 13:52:27,722 DEBUG : BROWSER_OUTPUT: 13:52:27 INFO - 2015-12-31 13:52:27,722 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 13:52:27 INFO - 2015-12-31 13:52:27,722 DEBUG : BROWSER_OUTPUT: Values: 278.9 13:52:27 INFO - 2015-12-31 13:52:27,722 DEBUG : BROWSER_OUTPUT: 13:52:27 INFO - 2015-12-31 13:52:27,723 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 13:52:27 INFO - 2015-12-31 13:52:27,723 DEBUG : BROWSER_OUTPUT: Values: 5159.8 13:52:27 INFO - 2015-12-31 13:52:27,723 DEBUG : BROWSER_OUTPUT: 13:52:27 INFO - 2015-12-31 13:52:27,723 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:925.07 Median:925.07 stddev:0.00 (0.0%) 13:52:27 INFO - 2015-12-31 13:52:27,723 DEBUG : BROWSER_OUTPUT: Values: 925.1 13:52:27 INFO - 2015-12-31 13:52:27,723 DEBUG : BROWSER_OUTPUT: 13:52:27 INFO - 2015-12-31 13:52:27,723 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:549.45 Median:549.45 stddev:0.00 (0.0%) 13:52:27 INFO - 2015-12-31 13:52:27,723 DEBUG : BROWSER_OUTPUT: Values: 549.5 13:52:27 INFO - 2015-12-31 13:52:27,724 DEBUG : BROWSER_OUTPUT: 13:52:27 INFO - 2015-12-31 13:52:27,724 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10784.95 Median:10784.95 stddev:0.00 (0.0%) 13:52:27 INFO - 2015-12-31 13:52:27,724 DEBUG : BROWSER_OUTPUT: Values: 10784.9 13:52:27 INFO - 2015-12-31 13:52:27,724 DEBUG : BROWSER_OUTPUT: 13:52:27 INFO - 2015-12-31 13:52:27,724 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25150.00 Median:25150.00 stddev:0.00 (0.0%) 13:52:27 INFO - 2015-12-31 13:52:27,724 DEBUG : BROWSER_OUTPUT: Values: 25150.0 13:52:27 INFO - 2015-12-31 13:52:27,724 DEBUG : BROWSER_OUTPUT: 13:52:27 INFO - 2015-12-31 13:52:27,724 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:514.65 Median:514.65 stddev:0.00 (0.0%) 13:52:27 INFO - 2015-12-31 13:52:27,724 DEBUG : BROWSER_OUTPUT: Values: 514.7 13:52:27 INFO - 2015-12-31 13:52:27,724 DEBUG : BROWSER_OUTPUT: 13:52:27 INFO - 2015-12-31 13:52:27,724 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 13:52:27 INFO - 2015-12-31 13:52:27,725 DEBUG : BROWSER_OUTPUT: Values: 4850.2 13:52:27 INFO - 2015-12-31 13:52:27,725 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:52:27 INFO - 2015-12-31 13:52:27,725 DEBUG : BROWSER_OUTPUT: 13:52:28 INFO - 2015-12-31 13:52:28,524 INFO : Browser exited with error code: 0 13:52:28 INFO - 2015-12-31 13:52:28,538 INFO : Completed test v8_7 (00:00:39) 13:52:28 INFO - 2015-12-31 13:52:28,772 INFO : Completed test suite (00:20:06) 13:52:28 INFO - 2015-12-31 13:52:28,772 DEBUG : Working with test: dromaeo_css 13:52:28 INFO - 2015-12-31 13:52:28,772 DEBUG : Generating results file: dromaeo_css 13:52:28 INFO - 2015-12-31 13:52:28,773 DEBUG : Working with test: kraken 13:52:28 INFO - 2015-12-31 13:52:28,774 DEBUG : Generating results file: kraken 13:52:28 INFO - 2015-12-31 13:52:28,774 INFO : javascript benchmark 13:52:28 INFO - 2015-12-31 13:52:28,774 DEBUG : Working with test: v8_7 13:52:28 INFO - 2015-12-31 13:52:28,774 DEBUG : Generating results file: v8_7 13:52:28 INFO - 2015-12-31 13:52:28,774 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:52:28 INFO - 2015-12-31 13:52:28,828 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 13:52:28 INFO - 2015-12-31 13:52:28,828 DEBUG : process_Request line: dromaeo_css 7204.35 graph.html#tests=[[72,52,43]] 13:52:28 INFO - 2015-12-31 13:52:28,828 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:52:28 INFO - 2015-12-31 13:52:28,856 DEBUG : process_Request line: kraken 1508.50 graph.html#tests=[[232,52,43]] 13:52:28 INFO - 2015-12-31 13:52:28,856 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:52:28 INFO - 2015-12-31 13:52:28,984 DEBUG : process_Request line: v8_7 23234.25 graph.html#tests=[[230,52,43]] 13:52:28 INFO - 2015-12-31 13:52:28,985 INFO : javascript benchmark 13:52:29 INFO - 2015-12-31 13:52:28,989 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3326.2848487575175, 3376.5441665375183, 3390.338883917634, 3411.5223868658386, 3414.248865249644, 5504.366997795255, 5509.228707980886, 5510.834674959748, 5515.310586176728, 5518.420565840579, 5490.615656904019, 5495.120780675093, 5504.4770746779095, 5530.419305972875, 5566.304211973504, 5018.322526458927, 5045.697258164503, 5111.974440127794, 5130.384353877521, 5144.742762861861, 4870.147724148278, 4975.975120124394, 4976.900461990758, 4989.401271847365, 5002.524760147799, 4966.925496117561, 5029.5221953914315, 5048.848534543969, 5053.772580233898, 5146.0, 5096.439391666913, 5129.25625784263, 5131.640785145023, 5145.6398052136365, 5171.482851714836, 4825.396825396825, 4901.191303434929, 5038.496150384969, 5048.217526283432, 5106.974465127651, 5247.107991641392, 5256.290400795881, 5270.57835373173, 5286.889753151842, 5343.064963631387, 5841.0362290222065, 5852.326982396994, 5885.882282354329, 5921.407859214087, 5927.496162826165, 5610.326760788732, 5666.716664166816, 5924.614900031527, 5926.992411290091, 5982.940170598282, 5608.943910560883, 5612.719364031823, 5617.101263797814, 5628.409017053233, 5633.521150702195, 6046.455818976313, 6052.394760524, 6070.3019152797115, 6071.301800293023, 6079.148919151322, 5613.129964855454, 5636.549076073904, 5723.055695810144, 5868.119782032644, 5869.853253668693, 5909.468147866627, 5965.701714914237, 5976.760929562769, 5978.760849565969, 5985.9401405986255, 5899.911501327483, 5943.0, 5949.881002380015, 5958.493528050078, 5967.522598192134, 5634.4365563443325, 5728.942710572925, 5730.140478928194, 5761.567882408836, 5945.375735547792, 4579.038401935631, 4597.172508948354, 4618.992844445152, 4621.745803980746, 4637.605803506673, 4129.834806607702, 4133.483314585676, 4137.0, 4143.109231515178, 4145.481814773153, 5488.094464413327, 5512.972435137799, 5620.437956204429, 5629.071203251499, 5761.020626493506, 5961.135635332853, 5975.492083172979, 5997.220361353084, 6027.21646185993, 6031.758729650853, 5686.943130568724, 5728.914066289009, 5744.454276843693, 5748.798792042258, 5758.88482230353, 4980.327655766498, 5025.422076461181, 5163.483651634807, 5273.288106105703, 5319.7340132993195, 6135.815925522242, 6167.444929956326, 6172.259328880473, 6176.382361763787, 6187.566870319124, 5825.679587622722, 6015.699215039231, 6031.0, 6034.788782392595, 6037.15479832815, 5992.0, 6054.636721796706, 6170.197874276495, 6177.938220617916, 6186.1648677427975, 5894.2926848778425, 5920.141579470866, 5920.467157955804, 5932.8813423732145, 5941.31674857397, 5710.543156547549, 5805.593608447368, 6004.0693692477735, 6005.429484198994, 6031.5476339273855, 5696.601237913472, 5699.2590963174525, 5758.078707406795, 5770.682612456355, 5802.419758024333, 5852.4147585241135, 5857.062869940789, 5866.765329386777, 5875.206847075761, 5885.823425297248, 5397.082495975615, 5492.862678433071, 5548.056830338772, 5837.912431313449, 5846.707664616667, 5819.679917604403, 5850.678212698343, 5897.0, 5901.232839730807, 5933.881322373442, 5704.0588302929555, 5727.942720572908, 5738.512226460798, 5739.483446489836, 5767.567432442667], "unit": "ms", "name": "dojo.html", "value": 5475.0260791613555}, {"lowerIsBetter": false, "replicates": [592.055671204429, 633.2337871175878, 637.716216283754, 638.3074364314715, 648.9513286503512, 32111.839440802793, 41450.134743936556, 41656.37515437263, 41737.791311043475, 41927.58072419275, 45076.3238551422, 45517.31724024134, 45765.7711711441, 45900.311495327594, 45924.08151836961, 9036.231920286784, 9103.408278461879, 9159.35884488086, 9197.218236449877, 9235.261179105655, 8944.284457243437, 8964.641414343418, 9064.410813297114, 9075.092490750938, 9080.636774529012, 8942.687005954793, 9005.964314103896, 9044.819103617956, 9057.45655260683, 9089.727308180765, 8879.0, 9041.050689677588, 9069.818603627957, 9078.319126065506, 9109.089091090904, 8876.378653494257, 8953.641854325884, 9042.050584688644, 9061.864072038925, 9062.093790620951, 41625.583744162774, 41893.79053104745, 42303.788481057396, 42529.36205956913, 42691.78654106709, 3846.519185101862, 3925.0776067624083, 4197.349410841324, 4329.653627709776, 4345.978270108661, 32054.038378848672, 32305.6769432305, 32320.353592928244, 32360.514592281135, 33347.33305333904, 3802.429635554689, 3896.7077469189926, 3906.9609303907164, 3970.4242884781543, 3974.5826688197612, 271183.0, 271193.0, 271488.0, 271706.0, 272217.63891180616, 43617.0, 43618.0, 43999.340009899875, 44068.0, 44134.0, 41061.794691026356, 41432.58567414287, 41636.58363416388, 41717.0, 41807.0, 15181.696366072616, 15358.769618455732, 15380.692386152214, 15386.0, 15423.460178893685, 11129.054030407506, 11167.38579378142, 11170.776584468427, 11297.943510282561, 11615.709607259887, 14926.626834329229, 14943.327550260265, 15001.399944002336, 15007.099574025593, 15039.172845493604, 5897.911531327033, 6030.6080104793045, 6126.08108783686, 6155.72299246535, 6179.0, 1005.5374527717332, 1009.8131845608439, 1038.6624347087077, 1076.2573824061374, 1098.6319582939805, 28759.532888465386, 28799.280017999718, 28905.710942890302, 28929.855350723534, 29512.0, 1079.8164312066967, 1097.237419993113, 1116.4417791104447, 1176.6293617510457, 1222.7065504279087, 14916.403343866124, 14929.70140597182, 14987.70024599502, 15011.0, 15291.388344466319, 411577.0, 527173.0, 527658.0, 530503.0, 560839.0, 55968.72015639896, 57194.42805571891, 57294.0, 57574.42425575691, 57601.13598296029, 1460.123925644626, 1463.3561233057421, 1464.9487267945783, 1475.2771142140275, 1489.8882583806042, 30686.846565767028, 31046.844765776026, 31131.0, 31788.205294867814, 31827.522587160747, 51916.0, 53232.467675322754, 53481.0, 53496.465035349145, 53679.0, 301796.0, 305318.0, 306192.0, 307044.0, 307835.0, 45269.54730452653, 45552.40566580154, 45679.0, 46028.0, 46114.538854611026, 47349.289760654305, 47731.76134119307, 48488.27267591059, 48517.5148248513, 49250.75374623104, 41214.21717575641, 41472.58527414687, 42356.57643423649, 43112.56887431211, 43424.0, 41130.193130473606, 41592.792036039624, 41673.0, 41680.58319416767, 41788.79105604574, 33155.0, 33287.33425331528, 33295.33409331848, 33360.0, 33390.0, 35823.64176358203, 35875.0, 36250.63749362472, 36902.44646330361, 37187.25625487421, 28074.578881317204, 28195.71804281931, 28199.43601128007, 28301.43397132087, 28556.0], "unit": "ms", "name": "ext.html", "value": 19272.91211216066}, {"lowerIsBetter": false, "replicates": [385.610533361305, 386.8027306073902, 389.76224503053135, 390.8768737847578, 392.8271560513374, 15920.124393158372, 17300.394486192985, 17543.82456175438, 18898.527536811587, 18972.810271897295, 11235.719107022329, 11336.093112550976, 11564.942175289132, 11869.050475961923, 11934.04527637789, 5007.674501157422, 5098.388193416777, 5114.181730923053, 5125.871853203663, 5135.306733590974, 4990.0, 5137.101007323722, 5302.416734159239, 5326.440723724011, 5333.759980800854, 5213.608979326546, 5226.137687281613, 5245.0, 5452.91820622691, 6116.938830611703, 6086.482648974865, 6099.085137229429, 6120.173776540177, 6141.447269745744, 6156.984097623887, 5376.193570964348, 5415.0523658360025, 5508.724563771795, 5514.172874068881, 5529.170624406372, 19623.01884905749, 20784.48038799027, 20831.583368332547, 21172.364829055154, 21225.0, 2130.989345053265, 2155.5904378168098, 2178.967315490269, 2207.1612787140944, 2264.723952427816, 10132.94933525335, 10328.380297182193, 10433.4871443641, 10624.309419887682, 14472.276386180649, 1792.3905872003581, 1856.0905156473232, 1888.282452667991, 1894.4032629721594, 1902.781180164285, 64267.0, 67768.3223167772, 68092.0, 68516.31483685199, 69090.65454672695, 10687.893121068846, 10941.0, 11008.504617292241, 11090.722731931766, 11099.334039957628, 14452.132872027712, 14676.192809395372, 14684.19236941957, 14735.336909839083, 14821.110733356034, 8002.799930001796, 8084.434089613788, 8265.049519305358, 8280.71017514384, 8290.792730181673, 8044.396670249755, 8049.919500804917, 8075.757727268191, 8085.312748416451, 8188.836223275501, 4666.2067448533835, 4708.152532544106, 4723.433188017391, 4733.526647335308, 4783.162946484421, 1965.7935916728823, 1968.0848405491229, 1970.753655793026, 1982.7125066865513, 1990.134291583166, 954.3176628710366, 967.3470407475066, 1005.8591797148405, 1006.9194464442827, 1034.7257976636197, 15233.0, 17403.73894391585, 18052.9097354515, 18170.727439088423, 18791.0, 489.24656029714555, 489.7404375680895, 495.69762444908577, 496.02531026533035, 523.8402287302409, 6069.575129740876, 6095.542834287447, 6183.783567575203, 6235.875282494416, 6247.250329960343, 635427.0, 660088.0, 664106.0, 667894.0, 683621.0, 85912.57043714741, 85993.57003215069, 86569.0, 86908.0, 88443.55778221197, 538.1927109335996, 538.8868337649137, 541.7670401727216, 541.983740487786, 543.3262754184861, 10938.507767150657, 11055.336679799238, 11074.944625276821, 11116.221864469733, 11149.609763658233, 37490.25019499649, 37598.62401375951, 37739.62260377471, 38091.619083809914, 38374.0, 49677.503224968736, 49887.0, 49941.25088123754, 50109.74945125251, 50700.239496406844, 9743.782027246594, 10160.644377446753, 10266.384016959006, 10321.071103600712, 10480.68557943263, 12005.519779208735, 17745.378911738026, 18484.630307394047, 18491.630167396845, 18654.44036678902, 15511.069335839886, 15527.068375897483, 15756.212189390713, 15864.206789660702, 15904.681906361577, 15191.468298609496, 15493.457728979882, 15659.060456372654, 15862.44481443144, 16198.757018644494, 16588.170591470138, 16591.41930032443, 16718.164091795607, 16906.323747050472, 17007.744883827, 10028.548715307683, 10353.275270730977, 10385.792284154426, 10456.372617642966, 10906.727331816768, 15950.680986379975, 16026.839731602535, 16210.837891620933, 16285.0, 16383.918080409521], "unit": "ms", "name": "jquery.html", "value": 8811.922002667412}, {"lowerIsBetter": false, "replicates": [1503.0906301687478, 1559.51654986954, 1640.3438624550172, 1709.546970052936, 1810.3935181714126, 6452.741890324393, 6668.433183179423, 7231.493795434321, 7578.962105189473, 7612.391008719296, 7502.88745668814, 7719.768406947801, 7776.455648104635, 7784.494007889483, 7798.142204357516, 2247.35950254178, 2273.727152741665, 2294.0365046680436, 2298.0233400804673, 2302.205739020044, 2233.62028455163, 2304.020791163757, 2314.5833749925005, 2315.5368926214824, 2319.489712263299, 2256.3569382725927, 2260.8982595783227, 2261.197274967379, 2272.704548408713, 2315.583195024895, 2278.100150440583, 2307.9844868257915, 2334.731505876829, 2334.9182778602753, 2336.462613598882, 2148.9785102148935, 2155.967660485094, 2157.8273738100916, 2161.5136594266323, 2168.8481806273567, 7678.577678227695, 7720.189380115119, 7742.690292388298, 7760.146383897767, 7769.145394006655, 4528.456585209763, 4586.862394128181, 4619.284010978304, 4622.168009758242, 4627.791749371287, 2868.5697145428144, 2940.1326608650284, 3002.9549556756447, 3006.3987202559574, 3013.186439661279, 971.1842052675786, 996.1283876607968, 1017.4658304390255, 1022.0903395977585, 1028.0541901450608, 9802.264830137769, 9878.259130565237, 9926.851097233548, 9949.353292036067, 9983.400995940267, 4097.97951010249, 4126.834926602963, 4131.9173616527505, 4142.798588409328, 4172.624463798273, 8682.348823838238, 8706.129387061243, 8747.343949203836, 8750.34372422071, 8755.824883502422, 4612.3542704021465, 4621.09888571732, 4651.511591282934, 4674.415698037746, 4691.038337140878, 3665.413533834627, 3706.5552133744122, 4227.640650544677, 4317.654587632982, 4321.0709697415205, 3655.469956856294, 3668.9816550917076, 3678.429843374281, 3686.893931820443, 3705.425659022802, 1162.4594563528, 1167.3812879174052, 1168.4216312925157, 1172.4137931034484, 1178.4755783676183, 1097.533548241994, 1116.8938950799661, 1120.6694025262568, 1400.4258254115764, 1465.0550394995169, 7188.496805223689, 7233.348998590152, 7239.0, 7262.673179706926, 7277.490575659759, 465.176637351892, 472.4849913594199, 476.5782282679784, 480.329939734069, 482.7103737757388, 5483.506484416342, 5500.642458240201, 5528.0, 5537.501624853782, 5567.415421380778, 8750.86873696895, 8755.474671519729, 9168.679096231599, 9361.485118318422, 9399.906000939904, 9042.276617870555, 9070.229030532479, 9123.589438475285, 9251.398659087137, 9319.347645664739, 7311.268873112753, 7465.888011679721, 7485.438592105614, 7589.506682065648, 7596.430267729832, 7292.088488938883, 7297.890531641923, 7302.050733404623, 7324.267573242633, 7327.963360183165, 8180.8363832721825, 8196.057453392936, 8260.301791983113, 8411.8738218928, 8434.156584341517, 8188.7952801180445, 8221.301189398968, 8224.342052635655, 8288.751337459886, 8311.25198732117, 6701.463882889259, 6924.4460443165435, 7147.928520714726, 7256.4194864411775, 7292.234315396807, 7723.9227607723205, 7744.5740484271655, 7803.063632364153, 7824.647890844812, 7856.567888765944, 7162.641867906688, 7247.275272472711, 7303.853922921406, 7414.8887766682465, 7443.3673137781725, 6803.217629972616, 6876.656167191521, 6920.480963927826, 6963.40811031068, 7129.0, 7079.8938015930835, 7348.30191131863, 7364.852702946018, 7372.741954031583, 7394.667239974106, 6697.3637504437, 6699.698513566998, 6735.49483788708, 6745.527813053235, 6745.898811517929, 6390.584612000205, 6401.55189136756, 6418.807435776934, 6429.453496452854, 6582.407583317525], "unit": "ms", "name": "mootools.html", "value": 4363.4845214844945}, {"lowerIsBetter": false, "replicates": [363.2535140286711, 364.7100555058729, 365.6855104610035, 375.1877185892543, 378.97347185696975, 6239.875202495948, 6310.747570097196, 6312.652804095778, 6369.426751592361, 6391.744330226797, 6126.2648482182085, 6261.279952805428, 6270.0, 6285.214348206474, 6310.148130002448, 4850.345203397549, 4853.733044682541, 4874.902501949959, 4881.3166156738, 4895.069936712013, 4875.366202393684, 4878.2682597610465, 4888.902221955576, 4891.682040667345, 4895.8776030599165, 4769.618430525549, 4865.48912364202, 4874.853754387356, 4877.146499362615, 4879.219324908016, 4839.806407743686, 4841.685290456145, 4843.24929635907, 4855.490173531799, 4859.416869975608, 4277.101808620194, 4298.032942587924, 4301.74189548625, 4314.899700576364, 4323.459567554056, 5874.853128671817, 5946.5540084493405, 5958.731857066399, 5963.344032156459, 5966.582339236255, 5652.265205523297, 5674.120511320752, 5689.6586204827845, 5691.800786972436, 5705.0, 6675.399214070709, 6681.832954176136, 6684.83287917801, 6697.162854643169, 6711.094002309675, 4786.2581299898575, 4786.473487916326, 4786.976065119652, 4787.545183207624, 4788.521147885183, 6843.863122737567, 6897.931020689779, 6951.131108611424, 6964.651767411659, 6982.79051628457, 4901.607871370282, 4908.042931628298, 4908.779104940215, 4909.607231421478, 4911.943932054625, 4975.601951843843, 4983.750812459362, 4984.327115839315, 4987.925181122286, 4996.975015124901, 5516.3380394352935, 5634.690092044895, 5644.491995720323, 5670.404607516234, 5682.119271512922, 6739.090222819955, 6761.628110453972, 6765.830854228585, 6772.390484856386, 6784.728610855511, 1674.4641714651195, 1716.7596536484903, 1717.2959086774363, 1718.2954988454924, 1726.894787336106, 1141.4806263150247, 1147.3517462633586, 1152.423788105947, 1154.1113342726221, 1175.3887978251432, 6503.4146926775875, 6505.0892874997535, 6506.4469520091325, 6525.086487891699, 6550.967245163743, 6878.931210687929, 6890.379865812101, 6926.930730692729, 6932.930670693329, 6946.027556142144, 6483.286838447767, 6491.480681545465, 6497.122888410098, 6503.28463868974, 6524.608523488606, 3812.046988252937, 3823.5794062653085, 3827.808609569566, 3838.788866612363, 3858.2283543291455, 7328.816779580447, 7328.973943647894, 7333.74331898381, 7338.77983660491, 7347.448941329421, 7157.785266441911, 7274.199838017814, 7297.087864016998, 7297.963510182415, 7301.89047164293, 7296.16094149169, 7317.926820731831, 7320.96339518299, 7325.4872158948365, 7327.45044121693, 7072.611006394698, 7077.858442831011, 7081.256468070778, 7087.0, 7090.184628767758, 6762.594244345355, 6917.27368626287, 6953.304669533006, 6969.477289203229, 6987.7204911802955, 7281.526700764433, 7289.380402665833, 7296.890546641911, 7298.306660867209, 7305.1233851938105, 4728.432588089314, 4753.6434767393275, 4755.453122890774, 4767.880802979815, 4768.284757286296, 6912.4815638826285, 6947.513674042769, 7076.964615176891, 7079.610621415665, 7083.256258093033, 6873.140857392826, 6880.965595171992, 6901.551399159039, 6902.309769023058, 6915.861682766216, 6843.247242803188, 6860.176778786378, 6873.896891546531, 6877.489716253432, 6880.346367095118, 6618.271990080991, 6745.12313399255, 6783.253842077466, 6786.4910131739325, 6807.217170025312, 6927.549709269083, 6947.930520694728, 6948.096747422803, 6955.756548520778, 6957.304269573002, 6707.463402927657, 6708.42978346846, 6711.664416779239, 6712.597244165366, 6722.226943901318], "unit": "ms", "name": "prototype.html", "value": 5134.6159748074415}, {"lowerIsBetter": false, "replicates": [780.8008957715783, 825.5253229393101, 841.1672444280165, 871.0244526130733, 899.9280057595392, 13257.602271931833, 13408.061435699505, 13412.128211666248, 13469.326533673326, 13479.056466047356, 13072.73854522909, 13835.308234588256, 13858.237796921165, 13860.861391386083, 13875.514356997508, 883.4213590098495, 890.6081324217356, 906.6962567539882, 912.0469109780263, 912.0514664748687, 908.1327332397577, 909.4770506958492, 913.2420091324218, 915.9267258619294, 917.3440989692368, 933.351320832022, 956.6173530587786, 962.1821451766012, 962.6438217859367, 964.0648570886265, 942.886853577575, 952.9380590261645, 953.5947222430474, 955.7276176289758, 958.3722661656626, 706.791496508526, 709.0, 710.8187412209905, 711.445072843178, 713.6110819603329, 13865.37605807731, 13923.373448194754, 13951.930240348835, 14022.43910243589, 14023.439062437592, 12702.80945785814, 12710.745785084338, 12771.680707982376, 12771.872281277161, 13413.597592072254, 9903.25725570585, 9993.750156246078, 10047.949760251226, 10216.080552750289, 10275.0, 3607.350676878161, 3612.843889955215, 3675.871344502956, 3679.3745063339297, 3681.1901381695984, 46859.765701171615, 47172.0, 47420.0, 47482.0, 48883.51116488825, 10097.596096156218, 10414.323069000491, 10535.473226338652, 10578.259521833552, 10584.57661693539, 17041.31834726597, 17071.231794569274, 17120.05839678805, 17120.229589668244, 17140.0, 7950.4832185907735, 7971.083325417651, 8024.919750802417, 8097.109317975136, 8190.385721070825, 4518.548145185455, 4552.908941821145, 4718.31584420264, 4727.361806156194, 4789.784459699322, 3149.3228955774616, 3179.364127174574, 3181.109289398972, 3181.427343078268, 3185.108169712484, 591.1694069831893, 591.2461611445442, 592.4993380593392, 598.850287428143, 599.1073300781803, 743.115692326141, 763.7479631721519, 769.7075111457722, 774.1832366853024, 776.1850057439666, 8832.955835220911, 8908.153725396207, 9118.544072796334, 9312.813743725088, 9337.673181438753, 667.4893706314673, 715.5349023135004, 740.2079774641082, 804.4690504267155, 804.8350088231898, 4442.53353397895, 4548.636109111263, 4592.494825569184, 4657.534246575316, 4726.787294571753, 55985.0, 56299.43700562942, 56711.43288567144, 57000.00499982481, 57144.428555714745, 48803.02393952101, 53019.734901325246, 53505.0, 53738.731306344, 53783.19325210125, 47380.52619473761, 47724.0, 48213.27680084801, 48444.515554844, 48904.99999999929, 9578.760530986781, 9847.409155450696, 9880.50597470138, 9974.351667141613, 10023.097921187129, 34855.65144348524, 34935.95990185406, 35186.824065879504, 35348.293034139686, 35784.105397364234, 44220.0, 46740.7662961683, 47117.0, 47129.2930606048, 47280.52719472761, 11405.771884562097, 11710.238834475731, 11823.467943942715, 11872.46573904159, 12090.335031572997, 13160.078794484294, 13229.669258268621, 13277.0, 13618.250996195304, 13731.244781536712, 11955.521779128738, 12313.13808033465, 12469.625911222678, 12676.23942563449, 12740.490380384681, 11808.527658893549, 11814.881851181379, 11878.465469054086, 11906.821397678868, 12320.199187052813, 10443.738906527095, 11873.406329683654, 12367.196132251374, 12660.746785064432, 12914.741705166032, 10367.740806479596, 10621.203409744454, 10671.733206669585, 10754.032137107697, 10903.836442453528, 10132.138768204784, 10584.0, 10618.150547955991, 10678.8932110681, 10697.358158510515], "unit": "ms", "name": "yui.html", "value": 6710.939875165904}], "name": "dromaeo_css", "value": 7204.345508265778}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 111.0, 110.0, 112.0, 129.0, 111.0, 110.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [150.0, 129.0, 151.0, 165.0, 123.0, 151.0, 148.0, 123.0, 156.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 142.1}, {"lowerIsBetter": true, "replicates": [165.0, 163.0, 161.0, 162.0, 162.0, 162.0, 160.0, 162.0, 163.0, 167.0], "unit": "ms", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [78.0, 74.0, 77.0, 155.0, 73.0, 74.0, 71.0, 74.0, 153.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 90.2}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 148.0, 92.0, 92.0, 92.0, 136.0, 92.0, 94.0, 144.0], "unit": "ms", "name": "audio-oscillator", "value": 107.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 148.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 97.0, 96.0, 95.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [62.0, 63.0, 62.0, 58.0, 59.0, 59.0, 59.0, 61.0, 59.0, 61.0], "unit": "ms", "name": "json-parse-financial", "value": 60.3}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 63.7}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 84.0, 82.0, 81.0, 81.0, 82.0, 81.0, 89.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.3}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 124.0, 117.0, 115.0, 119.0, 119.0, 125.0, 129.0, 112.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.2}, {"lowerIsBetter": true, "replicates": [136.0, 149.0, 151.0, 149.0, 150.0, 145.0, 151.0, 149.0, 149.0, 146.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.5}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 66.0, 67.0, 69.0, 66.0, 68.0, 67.0, 66.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1508.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.2845408247084], "unit": "score", "name": "Richards", "value": 214.88327399999997}, {"lowerIsBetter": false, "replicates": [166.9727834362999], "unit": "score", "name": "DeltaBlue", "value": 395.98070200000006}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [925.0693802035153], "unit": "score", "name": "RayTrace", "value": 799.928109}, {"lowerIsBetter": false, "replicates": [549.4505494505495], "unit": "score", "name": "Earley", "value": 1212.96266}, {"lowerIsBetter": false, "replicates": [10784.946236559139], "unit": "score", "name": "Boyer", "value": 61.79567198404785}, {"lowerIsBetter": false, "replicates": [25150.0], "unit": "score", "name": "RegExp", "value": 36.22206759443341}, {"lowerIsBetter": false, "replicates": [514.6529562982005], "unit": "score", "name": "Splay", "value": 158.3416533466533}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 23234.248887066646}]} 13:52:29 INFO - RETURN: dromaeo_css: 7204.35 13:52:29 INFO - RETURN: kraken: 1508.50 13:52:29 INFO - RETURN: v8_7: 23234.25 13:52:29 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23234.25"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1508.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7204.35"}}} 13:52:29 INFO - Return code: 0 13:52:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:52:29 INFO - # TBPL SUCCESS # 13:52:29 INFO - Running post-action listener: _resource_record_post_action 13:52:29 INFO - Running post-run listener: _resource_record_post_run 13:52:30 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 8192; Write bytes: 525893632; Read time: 104; Write time: 388852 13:52:30 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 4096; Write bytes: 248467456; Read time: 92; Write time: 240596 13:52:30 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276561920; Read time: 12; Write time: 148204 13:52:30 INFO - Running post-run listener: _upload_blobber_files 13:52:30 INFO - Blob upload gear active. 13:52:30 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:52:30 INFO - Copying logs to upload dir... 13:52:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1259.657197 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2015-12-31 13:52:29.679237) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-31 13:52:29.682917) ========= 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=fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hCYWmdewTwamvmpQFnxjzg/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009983 build_url: 'https://queue.taskcluster.net/v1/task/hCYWmdewTwamvmpQFnxjzg/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-31 13:52:29.734813) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 13:52:29.735189) ========= 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=fce1c2174958ee92775f70ae000001a3-1451595305.302640-879903413 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 13:52:29.786557) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 13:52:29.786909) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 13:52:29.787244) ========= ========= Total master_lag: 0.25 =========