builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-056 starttime: 1451493157.23 results: success (0) buildid: 20151230055437 builduid: 1ff89653729d4dad8b676ed552bb8ea4 revision: a7d36d3c727cc8691a8e81cff04401254051ebc0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:37.233747) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:37.234224) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:37.234532) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006282 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:37.257492) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:37.257805) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:37.276817) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:37.277224) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004564 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:37.327115) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:37.327419) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:37.327780) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:37.328055) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 08:32:38-- 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% 216M=0s 2015-12-30 08:32:38 (216 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179969 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:37.520176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:37.520613) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017583 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:37.570245) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:37.570659) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a7d36d3c727cc8691a8e81cff04401254051ebc0 --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 a7d36d3c727cc8691a8e81cff04401254051ebc0 --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=0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 08:32:38,850 truncating revision to first 12 chars 2015-12-30 08:32:38,851 Setting DEBUG logging. 2015-12-30 08:32:38,851 attempt 1/10 2015-12-30 08:32:38,851 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a7d36d3c727c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 08:32:39,383 unpacking tar archive at: mozilla-aurora-a7d36d3c727c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.826137 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:38.411822) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:38.412381) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:38.423819) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:38.424186) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 08:32:38.424681) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-30 08:32:38.424980) ========= /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=0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:32:39 INFO - MultiFileLogger online at 20151230 08:32:39 in /builds/slave/test-pgo 08:32:39 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 08:32:39 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:32:39 INFO - {'append_to_log': False, 08:32:39 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:32:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:32:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:32:39 INFO - 'branch': 'Mozilla-Aurora', 08:32:39 INFO - 'buildbot_json_path': 'buildprops.json', 08:32:39 INFO - 'config_files': ('talos/linux_config.py',), 08:32:39 INFO - 'default_actions': ('clobber', 08:32:39 INFO - 'read-buildbot-config', 08:32:39 INFO - 'download-and-extract', 08:32:39 INFO - 'populate-webroot', 08:32:39 INFO - 'create-virtualenv', 08:32:39 INFO - 'install', 08:32:39 INFO - 'run-tests'), 08:32:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:32:39 INFO - 'download_minidump_stackwalk': True, 08:32:39 INFO - 'download_symbols': 'ondemand', 08:32:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:32:39 INFO - 'tooltool.py': '/tools/tooltool.py', 08:32:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:32:39 INFO - '/tools/misc-python/virtualenv.py')}, 08:32:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:32:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:32:39 INFO - 'installer_path': 'installer.exe', 08:32:39 INFO - 'log_level': 'info', 08:32:39 INFO - 'log_name': 'talos', 08:32:39 INFO - 'log_to_console': True, 08:32:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:32:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:32:39 INFO - 'opt_config_files': (), 08:32:39 INFO - 'pip_index': False, 08:32:39 INFO - 'sps_profile': False, 08:32:39 INFO - 'sps_profile_interval': 0, 08:32:39 INFO - 'suite': 'dromaeojs-e10s', 08:32:39 INFO - 'system_bits': '32', 08:32:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:32:39 INFO - 'title': 'talos-linux64-ix-056', 08:32:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:32:39 INFO - 'use_talos_json': True, 08:32:39 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:32:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:32:39 INFO - 'work_dir': 'build'} 08:32:39 INFO - ##### 08:32:39 INFO - ##### Running clobber step. 08:32:39 INFO - ##### 08:32:39 INFO - Running pre-action listener: _resource_record_pre_action 08:32:39 INFO - Running main action method: clobber 08:32:39 INFO - rmtree: /builds/slave/test-pgo/build 08:32:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:32:40 INFO - Running post-action listener: _resource_record_post_action 08:32:40 INFO - ##### 08:32:40 INFO - ##### Running read-buildbot-config step. 08:32:40 INFO - ##### 08:32:40 INFO - Running pre-action listener: _resource_record_pre_action 08:32:40 INFO - Running main action method: read_buildbot_config 08:32:40 INFO - Using buildbot properties: 08:32:40 INFO - { 08:32:40 INFO - "properties": { 08:32:40 INFO - "buildnumber": 29, 08:32:40 INFO - "product": "firefox", 08:32:40 INFO - "script_repo_revision": "production", 08:32:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 08:32:40 INFO - "repository": "", 08:32:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 08:32:40 INFO - "buildid": "20151230055437", 08:32:40 INFO - "slavename": "talos-linux64-ix-056", 08:32:40 INFO - "pgo_build": "True", 08:32:40 INFO - "basedir": "/builds/slave/test-pgo", 08:32:40 INFO - "project": "", 08:32:40 INFO - "platform": "ubuntu64_hw", 08:32:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:32:40 INFO - "slavebuilddir": "test", 08:32:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:32:40 INFO - "branch": "mozilla-aurora", 08:32:40 INFO - "repo_path": "releases/mozilla-aurora", 08:32:40 INFO - "stage_platform": "linux64-pgo", 08:32:40 INFO - "builduid": "1ff89653729d4dad8b676ed552bb8ea4", 08:32:40 INFO - "revision": "a7d36d3c727cc8691a8e81cff04401254051ebc0" 08:32:40 INFO - }, 08:32:40 INFO - "sourcestamp": { 08:32:40 INFO - "repository": "", 08:32:40 INFO - "hasPatch": false, 08:32:40 INFO - "project": "", 08:32:40 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 08:32:40 INFO - "changes": [ 08:32:40 INFO - { 08:32:40 INFO - "category": null, 08:32:40 INFO - "files": [ 08:32:40 INFO - { 08:32:40 INFO - "url": null, 08:32:40 INFO - "name": "https://queue.taskcluster.net/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 08:32:40 INFO - } 08:32:40 INFO - ], 08:32:40 INFO - "repository": "", 08:32:40 INFO - "rev": "a7d36d3c727cc8691a8e81cff04401254051ebc0", 08:32:40 INFO - "who": "cbook@mozilla.com", 08:32:40 INFO - "when": 1451493071, 08:32:40 INFO - "number": 7403069, 08:32:40 INFO - "comments": "Bug 1234778 - Mark all audio frames as keyframes. r=kentuckyfriedtakahe, a=sylvestre", 08:32:40 INFO - "project": "", 08:32:40 INFO - "at": "Wed 30 Dec 2015 08:31:11", 08:32:40 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 08:32:40 INFO - "revlink": "", 08:32:40 INFO - "properties": [ 08:32:40 INFO - [ 08:32:40 INFO - "buildid", 08:32:40 INFO - "20151230055437", 08:32:40 INFO - "Change" 08:32:40 INFO - ], 08:32:40 INFO - [ 08:32:40 INFO - "builduid", 08:32:40 INFO - "1ff89653729d4dad8b676ed552bb8ea4", 08:32:40 INFO - "Change" 08:32:40 INFO - ], 08:32:40 INFO - [ 08:32:40 INFO - "pgo_build", 08:32:40 INFO - "True", 08:32:40 INFO - "Change" 08:32:40 INFO - ] 08:32:40 INFO - ], 08:32:40 INFO - "revision": "a7d36d3c727cc8691a8e81cff04401254051ebc0" 08:32:40 INFO - } 08:32:40 INFO - ], 08:32:40 INFO - "revision": "a7d36d3c727cc8691a8e81cff04401254051ebc0" 08:32:40 INFO - } 08:32:40 INFO - } 08:32:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 08:32:40 INFO - Running post-action listener: _resource_record_post_action 08:32:40 INFO - ##### 08:32:40 INFO - ##### Running download-and-extract step. 08:32:40 INFO - ##### 08:32:40 INFO - Running pre-action listener: _resource_record_pre_action 08:32:40 INFO - Running main action method: download_and_extract 08:32:40 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:32: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')]} 08:32:40 INFO - https://queue.taskcluster.net/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:32:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/test_packages.json 08:32:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/test_packages.json 08:32:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:32:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:32:44 INFO - Downloaded 1302 bytes. 08:32:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:32:44 INFO - Using the following test package requirements: 08:32:44 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 08:32:44 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:32:44 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:32:44 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:32:44 INFO - u'jsshell-linux-x86_64.zip'], 08:32:44 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:32:44 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:32:44 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 08:32:44 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:32:44 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:32:44 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:32:44 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:32:44 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:32:44 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:32:44 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 08:32:44 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 08:32:44 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:32:44 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:44 INFO - https://queue.taskcluster.net/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:32:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:32:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:32:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/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 08:32:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/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 08:32:51 INFO - Downloaded 23024002 bytes. 08:32:51 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 08:32:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:32:51 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 08:32:52 INFO - Return code: 0 08:32:52 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 08:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:32:52 INFO - https://queue.taskcluster.net/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:32:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:32:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:32:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/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 08:32:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/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 08:32:59 INFO - Downloaded 23024002 bytes. 08:32:59 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 08:32:59 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 08:32:59 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 08:33:00 INFO - Return code: 0 08:33: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')]} 08:33:00 INFO - https://queue.taskcluster.net/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:33:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 08:33:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 08:33:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/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 08:33:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/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 08:33:01 INFO - Downloaded 11132038 bytes. 08:33:01 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 08:33:01 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 08:33:01 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 08:33:01 INFO - Return code: 0 08:33: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')]} 08:33:01 INFO - https://queue.taskcluster.net/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:33:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 08:33:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 08:33:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/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 08:33:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WLvV-kAUSHqp2T2pFz9YuA/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 08:33:03 INFO - Downloaded 58084183 bytes. 08:33:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 08:33:03 INFO - mkdir: /builds/slave/test-pgo/properties 08:33:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:33:03 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:33:03 INFO - Contents: 08:33:03 INFO - build_url:https://queue.taskcluster.net/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 08:33:03 INFO - Running post-action listener: _resource_record_post_action 08:33:03 INFO - Running post-action listener: set_extra_try_arguments 08:33:03 INFO - ##### 08:33:03 INFO - ##### Running populate-webroot step. 08:33:03 INFO - ##### 08:33:03 INFO - Running pre-action listener: _resource_record_pre_action 08:33:03 INFO - Running main action method: populate_webroot 08:33:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:33:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:33:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:33:03 INFO - '--tppagecycles', 08:33:03 INFO - '7'], 08:33:03 INFO - 'tests': ['tsvgm']}}, 08:33:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:33:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:33:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:33:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:33:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:33:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:33:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:33:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:03 INFO - 'talos_options': ['--e10s'], 08:33:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:33:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:03 INFO - 'tests': ['damp', 'tps']}, 08:33:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:03 INFO - 'talos_options': ['--e10s'], 08:33:03 INFO - 'tests': ['damp', 'tps']}, 08:33:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:33:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:33:03 INFO - 'other': {'tests': ['a11yr', 08:33:03 INFO - 'ts_paint', 08:33:03 INFO - 'tpaint', 08:33:03 INFO - 'sessionrestore', 08:33:03 INFO - 'sessionrestore_no_auto_restore']}, 08:33:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:33:03 INFO - 'tests': ['a11yr', 08:33:03 INFO - 'ts_paint', 08:33:03 INFO - 'tpaint', 08:33:03 INFO - 'sessionrestore', 08:33:03 INFO - 'sessionrestore_no_auto_restore']}, 08:33:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:33:03 INFO - 'tests': ['a11yr', 08:33:03 INFO - 'ts_paint', 08:33:03 INFO - 'tpaint', 08:33:03 INFO - 'sessionrestore', 08:33:03 INFO - 'sessionrestore_no_auto_restore']}, 08:33:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:33:03 INFO - 'tests': ['a11yr', 08:33:03 INFO - 'ts_paint', 08:33:03 INFO - 'tpaint', 08:33:03 INFO - 'sessionrestore', 08:33:03 INFO - 'sessionrestore_no_auto_restore']}, 08:33:03 INFO - 'other_l64': {'tests': ['a11yr', 08:33:03 INFO - 'ts_paint', 08:33:03 INFO - 'tpaint', 08:33:03 INFO - 'sessionrestore', 08:33:03 INFO - 'sessionrestore_no_auto_restore']}, 08:33:03 INFO - 'other_nol64': {'tests': ['a11yr', 08:33:03 INFO - 'ts_paint', 08:33:03 INFO - 'tpaint', 08:33:03 INFO - 'sessionrestore', 08:33:03 INFO - 'sessionrestore_no_auto_restore']}, 08:33:03 INFO - 'svgr': {'tests': ['tsvgx', 08:33:03 INFO - 'tsvgr_opacity', 08:33:03 INFO - 'tart', 08:33:03 INFO - 'tscrollx', 08:33:03 INFO - 'cart']}, 08:33:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:33:03 INFO - 'tests': ['tsvgx', 08:33:03 INFO - 'tsvgr_opacity', 08:33:03 INFO - 'tart', 08:33:03 INFO - 'tscrollx', 08:33:03 INFO - 'cart']}, 08:33:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:03 INFO - 'tests': ['tp5o']}, 08:33:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:03 INFO - 'talos_options': ['--e10s'], 08:33:03 INFO - 'tests': ['tp5o']}, 08:33:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:03 INFO - 'talos_options': ['--xperf_path', 08:33:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:33:03 INFO - 'tests': ['tp5n']}, 08:33:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:33:03 INFO - 'talos_options': ['--e10s', 08:33:03 INFO - '--xperf_path', 08:33:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:33:03 INFO - 'tests': ['tp5n']}}, 08:33:03 INFO - 'talos.zip': {'path': '', 08:33:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:33:03 INFO - Running post-action listener: _resource_record_post_action 08:33:03 INFO - ##### 08:33:03 INFO - ##### Running create-virtualenv step. 08:33:03 INFO - ##### 08:33:03 INFO - Running pre-action listener: _resource_record_pre_action 08:33:03 INFO - Running main action method: create_virtualenv 08:33:03 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:33:03 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 08:33:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:33:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:33:03 INFO - Using real prefix '/usr' 08:33:03 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:33:04 INFO - Installing distribute.............................................................................................................................................................................................done. 08:33:06 INFO - Installing pip.................done. 08:33:06 INFO - Return code: 0 08:33:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:33:06 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')]} 08:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:06 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')]} 08:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:06 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 0x7fa77a547f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d56a0>, '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 0x24d65a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d6a30>, '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': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', '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 08:33:06 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 08:33:06 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 08:33:06 INFO - Using env: {'DISPLAY': ':0', 08:33:06 INFO - 'HOME': '/home/cltbld', 08:33:06 INFO - 'LANG': 'en_US.UTF-8', 08:33:06 INFO - 'LANGUAGE': 'en_US:en', 08:33:06 INFO - 'LOGNAME': 'cltbld', 08:33:06 INFO - 'MAIL': '/var/mail/cltbld', 08:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:06 INFO - 'MOZ_NO_REMOTE': '1', 08:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:06 INFO - 'NO_EM_RESTART': '1', 08:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:33:06 INFO - 'PWD': '/builds/slave/test-pgo', 08:33:06 INFO - 'SHELL': '/bin/bash', 08:33:06 INFO - 'SHLVL': '1', 08:33:06 INFO - 'TERM': 'linux', 08:33:06 INFO - 'TMOUT': '86400', 08:33:06 INFO - 'USER': 'cltbld', 08:33:06 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', 08:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:06 INFO - '_': '/tools/buildbot/bin/python'} 08:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:06 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 08:33:06 INFO - Cleaning up... 08:33:06 INFO - Return code: 0 08:33:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:33:06 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')]} 08:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:06 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')]} 08:33:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:06 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 0x7fa77a547f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d56a0>, '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 0x24d65a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d6a30>, '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': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', '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 08:33:06 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 08:33:06 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 08:33:06 INFO - Using env: {'DISPLAY': ':0', 08:33:06 INFO - 'HOME': '/home/cltbld', 08:33:06 INFO - 'LANG': 'en_US.UTF-8', 08:33:06 INFO - 'LANGUAGE': 'en_US:en', 08:33:06 INFO - 'LOGNAME': 'cltbld', 08:33:06 INFO - 'MAIL': '/var/mail/cltbld', 08:33:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:06 INFO - 'MOZ_NO_REMOTE': '1', 08:33:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:06 INFO - 'NO_EM_RESTART': '1', 08:33:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:33:06 INFO - 'PWD': '/builds/slave/test-pgo', 08:33:06 INFO - 'SHELL': '/bin/bash', 08:33:06 INFO - 'SHLVL': '1', 08:33:06 INFO - 'TERM': 'linux', 08:33:06 INFO - 'TMOUT': '86400', 08:33:06 INFO - 'USER': 'cltbld', 08:33:06 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', 08:33:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:06 INFO - '_': '/tools/buildbot/bin/python'} 08:33:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:06 INFO - Downloading/unpacking psutil>=0.7.1 08:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:08 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 08:33:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:33:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:33:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:33:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:33:08 INFO - Installing collected packages: psutil 08:33:08 INFO - Running setup.py install for psutil 08:33:08 INFO - building 'psutil._psutil_linux' extension 08:33:08 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 08:33:08 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 08:33:08 INFO - building 'psutil._psutil_posix' extension 08:33:08 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 08:33:09 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 08:33:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:33:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:33:09 INFO - Successfully installed psutil 08:33:09 INFO - Cleaning up... 08:33:09 INFO - Return code: 0 08:33:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa77a547f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d56a0>, '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 0x24d65a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d6a30>, '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': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', '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 08:33:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:33:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:33:09 INFO - Using env: {'DISPLAY': ':0', 08:33:09 INFO - 'HOME': '/home/cltbld', 08:33:09 INFO - 'LANG': 'en_US.UTF-8', 08:33:09 INFO - 'LANGUAGE': 'en_US:en', 08:33:09 INFO - 'LOGNAME': 'cltbld', 08:33:09 INFO - 'MAIL': '/var/mail/cltbld', 08:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:09 INFO - 'MOZ_NO_REMOTE': '1', 08:33:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:09 INFO - 'NO_EM_RESTART': '1', 08:33:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:33:09 INFO - 'PWD': '/builds/slave/test-pgo', 08:33:09 INFO - 'SHELL': '/bin/bash', 08:33:09 INFO - 'SHLVL': '1', 08:33:09 INFO - 'TERM': 'linux', 08:33:09 INFO - 'TMOUT': '86400', 08:33:09 INFO - 'USER': 'cltbld', 08:33:09 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', 08:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:09 INFO - '_': '/tools/buildbot/bin/python'} 08:33:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:33:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:33:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:33:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:33:11 INFO - Installing collected packages: mozsystemmonitor 08:33:11 INFO - Running setup.py install for mozsystemmonitor 08:33:11 INFO - Successfully installed mozsystemmonitor 08:33:11 INFO - Cleaning up... 08:33:11 INFO - Return code: 0 08:33:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa77a547f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d56a0>, '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 0x24d65a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d6a30>, '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': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', '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 08:33:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:33:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:33:11 INFO - Using env: {'DISPLAY': ':0', 08:33:11 INFO - 'HOME': '/home/cltbld', 08:33:11 INFO - 'LANG': 'en_US.UTF-8', 08:33:11 INFO - 'LANGUAGE': 'en_US:en', 08:33:11 INFO - 'LOGNAME': 'cltbld', 08:33:11 INFO - 'MAIL': '/var/mail/cltbld', 08:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:11 INFO - 'MOZ_NO_REMOTE': '1', 08:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:11 INFO - 'NO_EM_RESTART': '1', 08:33:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:33:11 INFO - 'PWD': '/builds/slave/test-pgo', 08:33:11 INFO - 'SHELL': '/bin/bash', 08:33:11 INFO - 'SHLVL': '1', 08:33:11 INFO - 'TERM': 'linux', 08:33:11 INFO - 'TMOUT': '86400', 08:33:11 INFO - 'USER': 'cltbld', 08:33:11 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', 08:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:11 INFO - '_': '/tools/buildbot/bin/python'} 08:33:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:11 INFO - Downloading/unpacking blobuploader==1.2.4 08:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:13 INFO - Downloading blobuploader-1.2.4.tar.gz 08:33:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:33:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:33:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:33:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:33:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:13 INFO - Downloading docopt-0.6.1.tar.gz 08:33:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:33:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:33:14 INFO - Installing collected packages: blobuploader, requests, docopt 08:33:14 INFO - Running setup.py install for blobuploader 08:33:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:33:14 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:33:14 INFO - Running setup.py install for requests 08:33:14 INFO - Running setup.py install for docopt 08:33:14 INFO - Successfully installed blobuploader requests docopt 08:33:14 INFO - Cleaning up... 08:33:14 INFO - Return code: 0 08:33:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:14 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 0x7fa77a547f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d56a0>, '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 0x24d65a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d6a30>, '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': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', '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 08:33:14 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 08:33:14 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 08:33:14 INFO - Using env: {'DISPLAY': ':0', 08:33:14 INFO - 'HOME': '/home/cltbld', 08:33:14 INFO - 'LANG': 'en_US.UTF-8', 08:33:14 INFO - 'LANGUAGE': 'en_US:en', 08:33:14 INFO - 'LOGNAME': 'cltbld', 08:33:14 INFO - 'MAIL': '/var/mail/cltbld', 08:33:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:14 INFO - 'MOZ_NO_REMOTE': '1', 08:33:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:14 INFO - 'NO_EM_RESTART': '1', 08:33:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:33:14 INFO - 'PWD': '/builds/slave/test-pgo', 08:33:14 INFO - 'SHELL': '/bin/bash', 08:33:14 INFO - 'SHLVL': '1', 08:33:14 INFO - 'TERM': 'linux', 08:33:14 INFO - 'TMOUT': '86400', 08:33:14 INFO - 'USER': 'cltbld', 08:33:14 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', 08:33:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:14 INFO - '_': '/tools/buildbot/bin/python'} 08:33:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:33:14 INFO - Running setup.py (path:/tmp/pip-mQpl3V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:33:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:33:14 INFO - Running setup.py (path:/tmp/pip-DnMO_8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:33:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:33:15 INFO - Running setup.py (path:/tmp/pip-Wy6Q5m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:33:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:33:15 INFO - Running setup.py (path:/tmp/pip-xTT_wO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:33:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:33:15 INFO - Running setup.py (path:/tmp/pip-1RZLna-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:33:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:33:15 INFO - Running setup.py (path:/tmp/pip-YCHZmJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:33:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:33:15 INFO - Running setup.py (path:/tmp/pip-6I1ecd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:33:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:33:15 INFO - Running setup.py (path:/tmp/pip-hqLYFA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:33:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:33:15 INFO - Running setup.py (path:/tmp/pip-11MGxv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:33:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:33:15 INFO - Running setup.py (path:/tmp/pip-r7vMIy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:33:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:33:15 INFO - Running setup.py (path:/tmp/pip-NuB0Cd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:33:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:33:15 INFO - Running setup.py (path:/tmp/pip-CNZ3h5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:33:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:33:15 INFO - Running setup.py (path:/tmp/pip-yUAijH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:33:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:33:15 INFO - Running setup.py (path:/tmp/pip-U3Rh_o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:33:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:33:15 INFO - Running setup.py (path:/tmp/pip-SwKlSf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:33:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:33:15 INFO - Running setup.py (path:/tmp/pip-YtxUn8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:33:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:33:16 INFO - Running setup.py (path:/tmp/pip-pP819C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:33:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:33:16 INFO - Running setup.py install for manifestparser 08:33:16 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:33:16 INFO - Running setup.py install for mozcrash 08:33:16 INFO - Running setup.py install for mozdebug 08:33:16 INFO - Running setup.py install for mozdevice 08:33:16 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:33:16 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:33:16 INFO - Running setup.py install for mozfile 08:33:16 INFO - Running setup.py install for mozhttpd 08:33:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:33:16 INFO - Running setup.py install for mozinfo 08:33:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:33:16 INFO - Running setup.py install for mozInstall 08:33:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:33:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:33:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:33:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:33:16 INFO - Running setup.py install for mozleak 08:33:16 INFO - Running setup.py install for mozlog 08:33:17 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:33:17 INFO - Running setup.py install for moznetwork 08:33:17 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:33:17 INFO - Running setup.py install for mozprocess 08:33:17 INFO - Running setup.py install for mozprofile 08:33:17 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:33:17 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:33:17 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:33:17 INFO - Running setup.py install for mozrunner 08:33:17 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:33:17 INFO - Running setup.py install for mozscreenshot 08:33:17 INFO - Running setup.py install for moztest 08:33:17 INFO - Running setup.py install for mozversion 08:33:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:33:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:33:17 INFO - Cleaning up... 08:33:17 INFO - Return code: 0 08:33:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:33:17 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')]} 08:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:17 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')]} 08:33:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:17 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 0x7fa77a547f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d56a0>, '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 0x24d65a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d6a30>, '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': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', '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 08:33:17 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 08:33:17 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 08:33:17 INFO - Using env: {'DISPLAY': ':0', 08:33:17 INFO - 'HOME': '/home/cltbld', 08:33:17 INFO - 'LANG': 'en_US.UTF-8', 08:33:17 INFO - 'LANGUAGE': 'en_US:en', 08:33:17 INFO - 'LOGNAME': 'cltbld', 08:33:17 INFO - 'MAIL': '/var/mail/cltbld', 08:33:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:17 INFO - 'MOZ_NO_REMOTE': '1', 08:33:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:17 INFO - 'NO_EM_RESTART': '1', 08:33:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:33:17 INFO - 'PWD': '/builds/slave/test-pgo', 08:33:17 INFO - 'SHELL': '/bin/bash', 08:33:17 INFO - 'SHLVL': '1', 08:33:17 INFO - 'TERM': 'linux', 08:33:17 INFO - 'TMOUT': '86400', 08:33:17 INFO - 'USER': 'cltbld', 08:33:17 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', 08:33:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:17 INFO - '_': '/tools/buildbot/bin/python'} 08:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:33:18 INFO - Running setup.py (path:/tmp/pip-Yf3RZr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:33:18 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)) 08:33:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:33:18 INFO - Running setup.py (path:/tmp/pip-8mejSw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:33:18 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)) 08:33:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:33:18 INFO - Running setup.py (path:/tmp/pip-ajEor2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:33:18 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)) 08:33:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:33:18 INFO - Running setup.py (path:/tmp/pip-sQfJqD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:33:18 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)) 08:33:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:33:18 INFO - Running setup.py (path:/tmp/pip-FQOSAo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:33:18 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)) 08:33:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:33:18 INFO - Running setup.py (path:/tmp/pip-GrtH61-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:33:18 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)) 08:33:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:33:18 INFO - Running setup.py (path:/tmp/pip-QHKDAU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:33:18 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)) 08:33:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:33:18 INFO - Running setup.py (path:/tmp/pip-pIq5Wg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:33:18 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)) 08:33:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:33:18 INFO - Running setup.py (path:/tmp/pip-lmRSF1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:33:18 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)) 08:33:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:33:18 INFO - Running setup.py (path:/tmp/pip-vPWzCh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:33:18 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)) 08:33:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:33:18 INFO - Running setup.py (path:/tmp/pip-z5x9EK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:33:18 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)) 08:33:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:33:18 INFO - Running setup.py (path:/tmp/pip-6zLkgc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:33:18 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)) 08:33:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:33:18 INFO - Running setup.py (path:/tmp/pip-gS9PFL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:33:19 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)) 08:33:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:33:19 INFO - Running setup.py (path:/tmp/pip-17XY66-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:33:19 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)) 08:33:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:33:19 INFO - Running setup.py (path:/tmp/pip-5pa1l2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:33:19 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)) 08:33:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:33:19 INFO - Running setup.py (path:/tmp/pip-Jkx77g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:33:19 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)) 08:33:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:33:19 INFO - Running setup.py (path:/tmp/pip-d0JsTN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:33:19 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)) 08:33:19 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)) 08:33:19 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)) 08:33:19 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)) 08:33:19 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)) 08:33:19 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)) 08:33:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:20 INFO - Downloading blessings-1.5.1.tar.gz 08:33:20 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 08:33:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:33:21 INFO - Installing collected packages: blessings 08:33:21 INFO - Running setup.py install for blessings 08:33:21 INFO - Successfully installed blessings 08:33:21 INFO - Cleaning up... 08:33:21 INFO - Return code: 0 08:33:21 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:33:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:33:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:33:21 INFO - Reading from file tmpfile_stdout 08:33:21 INFO - Current package versions: 08:33:21 INFO - argparse == 1.2.1 08:33:21 INFO - blessings == 1.5.1 08:33:21 INFO - blobuploader == 1.2.4 08:33:21 INFO - docopt == 0.6.1 08:33:21 INFO - manifestparser == 1.1 08:33:21 INFO - mozInstall == 1.12 08:33:21 INFO - mozcrash == 0.16 08:33:21 INFO - mozdebug == 0.1 08:33:21 INFO - mozdevice == 0.47 08:33:21 INFO - mozfile == 1.2 08:33:21 INFO - mozhttpd == 0.7 08:33:21 INFO - mozinfo == 0.9 08:33:21 INFO - mozleak == 0.1 08:33:21 INFO - mozlog == 3.1 08:33:21 INFO - moznetwork == 0.27 08:33:21 INFO - mozprocess == 0.22 08:33:21 INFO - mozprofile == 0.27 08:33:21 INFO - mozrunner == 6.11 08:33:21 INFO - mozscreenshot == 0.1 08:33:21 INFO - mozsystemmonitor == 0.0 08:33:21 INFO - moztest == 0.7 08:33:21 INFO - mozversion == 1.4 08:33:21 INFO - psutil == 3.1.1 08:33:21 INFO - requests == 1.2.3 08:33:21 INFO - wsgiref == 0.1.2 08:33:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:33: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')]} 08:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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')]} 08:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:21 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 0x7fa77a547f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d56a0>, '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 0x24d65a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d6a30>, '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': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', '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 08:33:21 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 08:33:21 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 08:33:21 INFO - Using env: {'DISPLAY': ':0', 08:33:21 INFO - 'HOME': '/home/cltbld', 08:33:21 INFO - 'LANG': 'en_US.UTF-8', 08:33:21 INFO - 'LANGUAGE': 'en_US:en', 08:33:21 INFO - 'LOGNAME': 'cltbld', 08:33:21 INFO - 'MAIL': '/var/mail/cltbld', 08:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:21 INFO - 'MOZ_NO_REMOTE': '1', 08:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:21 INFO - 'NO_EM_RESTART': '1', 08:33:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:33:21 INFO - 'PWD': '/builds/slave/test-pgo', 08:33:21 INFO - 'SHELL': '/bin/bash', 08:33:21 INFO - 'SHLVL': '1', 08:33:21 INFO - 'TERM': 'linux', 08:33:21 INFO - 'TMOUT': '86400', 08:33:21 INFO - 'USER': 'cltbld', 08:33:21 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', 08:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:21 INFO - '_': '/tools/buildbot/bin/python'} 08:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:21 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)) 08:33:21 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)) 08:33:21 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)) 08:33:21 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)) 08:33:21 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)) 08:33:21 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)) 08:33:21 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)) 08:33:21 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)) 08:33:21 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)) 08:33:21 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)) 08:33:21 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)) 08:33:21 INFO - Cleaning up... 08:33:21 INFO - Return code: 0 08:33:21 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:33: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')]} 08:33:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33: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')]} 08:33:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:21 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 0x7fa77a547f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d56a0>, '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 0x24d65a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d6a30>, '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': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', '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 08:33:21 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 08:33:21 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 08:33:21 INFO - Using env: {'DISPLAY': ':0', 08:33:21 INFO - 'HOME': '/home/cltbld', 08:33:21 INFO - 'LANG': 'en_US.UTF-8', 08:33:21 INFO - 'LANGUAGE': 'en_US:en', 08:33:21 INFO - 'LOGNAME': 'cltbld', 08:33:21 INFO - 'MAIL': '/var/mail/cltbld', 08:33:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:21 INFO - 'MOZ_NO_REMOTE': '1', 08:33:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:21 INFO - 'NO_EM_RESTART': '1', 08:33:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:33:21 INFO - 'PWD': '/builds/slave/test-pgo', 08:33:21 INFO - 'SHELL': '/bin/bash', 08:33:21 INFO - 'SHLVL': '1', 08:33:21 INFO - 'TERM': 'linux', 08:33:21 INFO - 'TMOUT': '86400', 08:33:21 INFO - 'USER': 'cltbld', 08:33:21 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', 08:33:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:21 INFO - '_': '/tools/buildbot/bin/python'} 08:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:21 INFO - Downloading/unpacking jsonschema 08:33:21 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 08:33:21 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 08:33:21 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 08:33:21 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 08:33:21 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 08:33:21 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 08:33:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:33:23 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 08:33:23 INFO - Downloading/unpacking functools32 (from jsonschema) 08:33:23 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 08:33:23 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 08:33:23 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 08:33:23 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 08:33:23 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 08:33:23 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 08:33:23 INFO - Downloading functools32-3.2.3-2.tar.gz 08:33:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:33:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:33:23 INFO - warning: no files found matching '*.txt' 08:33:23 INFO - no previously-included directories found matching 'build' 08:33:23 INFO - no previously-included directories found matching 'dist' 08:33:23 INFO - no previously-included directories found matching '.git*' 08:33:23 INFO - Installing collected packages: jsonschema, functools32 08:33:23 INFO - Running setup.py install for functools32 08:33:23 INFO - warning: no files found matching '*.txt' 08:33:23 INFO - no previously-included directories found matching 'build' 08:33:23 INFO - no previously-included directories found matching 'dist' 08:33:23 INFO - no previously-included directories found matching '.git*' 08:33:23 INFO - Successfully installed jsonschema functools32 08:33:23 INFO - Cleaning up... 08:33:24 INFO - Return code: 0 08:33:24 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:33:24 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 0x7fa77a547f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24d8500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24d56a0>, '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 0x24d65a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d6a30>, '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': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', '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 08:33:24 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 08:33:24 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 08:33:24 INFO - Using env: {'DISPLAY': ':0', 08:33:24 INFO - 'HOME': '/home/cltbld', 08:33:24 INFO - 'LANG': 'en_US.UTF-8', 08:33:24 INFO - 'LANGUAGE': 'en_US:en', 08:33:24 INFO - 'LOGNAME': 'cltbld', 08:33:24 INFO - 'MAIL': '/var/mail/cltbld', 08:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:24 INFO - 'MOZ_NO_REMOTE': '1', 08:33:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:24 INFO - 'NO_EM_RESTART': '1', 08:33:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:33:24 INFO - 'PWD': '/builds/slave/test-pgo', 08:33:24 INFO - 'SHELL': '/bin/bash', 08:33:24 INFO - 'SHLVL': '1', 08:33:24 INFO - 'TERM': 'linux', 08:33:24 INFO - 'TMOUT': '86400', 08:33:24 INFO - 'USER': 'cltbld', 08:33:24 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', 08:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:24 INFO - '_': '/tools/buildbot/bin/python'} 08:33:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:33:24 INFO - Downloading/unpacking flake8 08:33:24 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 08:33:24 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 08:33:24 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 08:33:24 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 08:33:24 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 08:33:24 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 08:33:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:33:25 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 08:33:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:33:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:33:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:33:26 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 08:33:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:33:26 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 08:33:26 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 08:33:26 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 08:33:26 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 08:33:26 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 08:33:26 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 08:33:26 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 08:33:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:33:26 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 08:33:26 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 08:33:26 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 08:33:26 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 08:33:26 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 08:33:26 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 08:33:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:33:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:33:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:33:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:33:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:33:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:33:26 INFO - no previously-included directories found matching 'docs/_build' 08:33:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:33:26 INFO - Running setup.py install for pep8 08:33:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:33:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:33:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:33:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:33:26 INFO - no previously-included directories found matching 'docs/_build' 08:33:26 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:33:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:33:26 INFO - Cleaning up... 08:33:26 INFO - Return code: 0 08:33:26 INFO - Running post-action listener: _resource_record_post_action 08:33:26 INFO - Running post-action listener: _start_resource_monitoring 08:33:26 INFO - Starting resource monitoring. 08:33:26 INFO - ##### 08:33:26 INFO - ##### Running install step. 08:33:26 INFO - ##### 08:33:26 INFO - Running pre-action listener: _resource_record_pre_action 08:33:26 INFO - Running main action method: install 08:33:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:33:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:33:27 INFO - Reading from file tmpfile_stdout 08:33:27 INFO - Detecting whether we're running mozinstall >=1.0... 08:33:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:33:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:33:27 INFO - Reading from file tmpfile_stdout 08:33:27 INFO - Output received: 08:33:27 INFO - Usage: mozinstall [options] installer 08:33:27 INFO - Options: 08:33:27 INFO - -h, --help show this help message and exit 08:33:27 INFO - -d DEST, --destination=DEST 08:33:27 INFO - Directory to install application into. [default: 08:33:27 INFO - "/builds/slave/test-pgo"] 08:33:27 INFO - --app=APP Application being installed. [default: firefox] 08:33:27 INFO - mkdir: /builds/slave/test-pgo/build/application 08:33:27 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'] 08:33:27 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 08:33:41 INFO - Reading from file tmpfile_stdout 08:33:41 INFO - Output received: 08:33:41 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:33:41 INFO - Running post-action listener: _resource_record_post_action 08:33:41 INFO - ##### 08:33:41 INFO - ##### Running run-tests step. 08:33:41 INFO - ##### 08:33:41 INFO - Running pre-action listener: _resource_record_pre_action 08:33:41 INFO - Running main action method: run_tests 08:33:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:33:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:33:41 INFO - Python 2.7.3 08:33:41 INFO - Return code: 0 08:33:41 INFO - grabbing minidump binary from tooltool 08:33: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')]} 08:33:41 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 0x24d56a0>, '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 0x24d65a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24d6a30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:33:41 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 08:33:41 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 08:33:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:33:41 INFO - Return code: 0 08:33:41 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:33:41 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:33:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:33:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:33:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:33:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:33:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:33:42 INFO - Return code: 0 08:33:42 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/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 08:33:42 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/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost 08:33:42 INFO - Using env: {'DISPLAY': ':0', 08:33:42 INFO - 'HOME': '/home/cltbld', 08:33:42 INFO - 'LANG': 'en_US.UTF-8', 08:33:42 INFO - 'LANGUAGE': 'en_US:en', 08:33:42 INFO - 'LOGNAME': 'cltbld', 08:33:42 INFO - 'MAIL': '/var/mail/cltbld', 08:33:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:33:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:33:42 INFO - 'MOZ_NO_REMOTE': '1', 08:33:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:33:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:33:42 INFO - 'NO_EM_RESTART': '1', 08:33:42 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:33:42 INFO - 'PWD': '/builds/slave/test-pgo', 08:33:42 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:33:42 INFO - 'SHELL': '/bin/bash', 08:33:42 INFO - 'SHLVL': '1', 08:33:42 INFO - 'TERM': 'linux', 08:33:42 INFO - 'TMOUT': '86400', 08:33:42 INFO - 'USER': 'cltbld', 08:33:42 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869', 08:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:33:42 INFO - '_': '/tools/buildbot/bin/python'} 08:33:42 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/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] with output_timeout 3600 08:33:42 INFO - mozversion INFO | application_buildid: 20151230055437 08:33:42 INFO - mozversion INFO | application_changeset: a7d36d3c727cc8691a8e81cff04401254051ebc0 08:33:42 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 08:33:42 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:33:42 INFO - mozversion INFO | application_name: Firefox 08:33:42 INFO - mozversion INFO | application_remotingname: firefox-dev 08:33:42 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:33:42 INFO - mozversion INFO | application_vendor: Mozilla 08:33:42 INFO - mozversion INFO | application_version: 45.0a2 08:33:42 INFO - mozversion INFO | platform_buildid: 20151230055437 08:33:42 INFO - mozversion INFO | platform_changeset: a7d36d3c727cc8691a8e81cff04401254051ebc0 08:33:42 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:33:42 INFO - mozversion INFO | platform_version: 45.0a2 08:33:42 INFO - 2015-12-30 08:33:42,876 DEBUG : using testdate: 1451493222 08:33:42 INFO - 2015-12-30 08:33:42,877 DEBUG : actual date: 1451493222 08:33:42 INFO - 2015-12-30 08:33:42,888 INFO : starting webserver on 'localhost:35769' 08:33:42 INFO - 2015-12-30 08:33:42,889 INFO : Starting test suite talos-linux64-ix-056.e 08:33:42 INFO - 2015-12-30 08:33:42,889 INFO : Starting test dromaeo_css 08:33:42 INFO - 2015-12-30 08:33:42,889 DEBUG : operating with platform_type : linux_ 08:33:42 INFO - 2015-12-30 08:33:42,890 INFO : Initialising browser for dromaeo_css test... 08:33:42 INFO - 2015-12-30 08:33:42,907 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfST29E/profile http://localhost:35769/getInfo.html 08:33:48 INFO - 2015-12-30 08:33:48,157 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:33:48 INFO - 2015-12-30 08:33:48,157 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:33:48 INFO - 2015-12-30 08:33:48,157 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:33:48 INFO - 2015-12-30 08:33:48,157 DEBUG : BROWSER_OUTPUT: __metrics 08:33:49 INFO - 2015-12-30 08:33:49,125 INFO : Browser initialized. 08:33:49 INFO - 2015-12-30 08:33:49,126 INFO : Running cycle 1/1 for dromaeo_css test... 08:33:49 INFO - 2015-12-30 08:33:49,126 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfST29E/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:34:00 INFO - 2015-12-30 08:34:00,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 136777728 08:34:00 INFO - 2015-12-30 08:34:00,855 DEBUG : BROWSER_OUTPUT: 08:34:50 INFO - 2015-12-30 08:34:50,490 DEBUG : BROWSER_OUTPUT: 1451493290483 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] 08:36:58 INFO - 2015-12-30 08:36:58,461 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35769/tests/dromaeo/cssquery-ext.html) 08:36:59 INFO - 2015-12-30 08:36:59,507 DEBUG : BROWSER_OUTPUT: RSS: Main: 140881920 08:36:59 INFO - 2015-12-30 08:36:59,507 DEBUG : BROWSER_OUTPUT: 08:40:01 INFO - 2015-12-30 08:40:01,324 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/dromaeo/cssquery-ext.html (next: http://localhost:35769/tests/dromaeo/cssquery-jquery.html) 08:40:01 INFO - 2015-12-30 08:40:01,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 139419648 08:40:01 INFO - 2015-12-30 08:40:01,913 DEBUG : BROWSER_OUTPUT: 08:43:03 INFO - 2015-12-30 08:43:03,540 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35769/tests/dromaeo/cssquery-mootools.html) 08:43:04 INFO - 2015-12-30 08:43:04,125 DEBUG : BROWSER_OUTPUT: RSS: Main: 139988992 08:43:04 INFO - 2015-12-30 08:43:04,125 DEBUG : BROWSER_OUTPUT: 08:46:05 INFO - 2015-12-30 08:46:05,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35769/tests/dromaeo/cssquery-prototype.html) 08:46:06 INFO - 2015-12-30 08:46:06,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 138747904 08:46:06 INFO - 2015-12-30 08:46:06,284 DEBUG : BROWSER_OUTPUT: 08:49:08 INFO - 2015-12-30 08:49:08,554 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35769/tests/dromaeo/cssquery-yui.html) 08:49:09 INFO - 2015-12-30 08:49:09,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 139644928 08:49:09 INFO - 2015-12-30 08:49:09,148 DEBUG : BROWSER_OUTPUT: 08:52:11 INFO - 2015-12-30 08:52:11,120 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/dromaeo/cssquery-yui.html (next: http://localhost:35769/tests/dromaeo/cssquery-dojo.html) 08:52:11 INFO - 2015-12-30 08:52:11,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 141099008 08:52:11 INFO - 2015-12-30 08:52:11,371 DEBUG : BROWSER_OUTPUT: 08:52:11 INFO - 2015-12-30 08:52:11,371 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:52:11 INFO - 2015-12-30 08:52:11,371 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:52:11 INFO - 2015-12-30 08:52:11,371 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:52:11 INFO - 2015-12-30 08:52:11,371 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:52:11 INFO - 2015-12-30 08:52:11,373 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3405.659434056594;3418.5214070030215;3456.118689734119;3467.49721290413;3494.930101397972;5614.1298098794705;5665.943340566593;5732.79935202268;5741.569382296324;5745.5690823188215;5666.801661941833;5676.205331253628;5725.541956643469;5730.197772311869;5780.884382312352;5188.143956247215;5218.347706536683;5281.5774738021055;5306.124489459235;5310.123829568117;5116.872078198037;5178.689278643294;5236.7119808410525;5244.318238628973;5292.761825717852;5132.204508301219;5193.506616871391;5195.116830138885;5197.558207552343;5228.0850851101095;5238.685678859261;5248.6588371755715;5263.210518422229;5290.735463226862;5295.364556253236;5048.697078175322;5083.949160508385;5101.744912754384;5191.428942816287;5191.8182863599595;5327.680339179662;5409.459054094559;5427.267318911936;5447.972760136214;5458.972705136489;5986.341502434729;5991.281046274431;6008.579399442041;6021.2473440819895;6035.7283922223605;6040.0939859021055;6092.847678808065;6128.594790794166;6145.0782382642965;6266.717997690115;5762.798302059449;5769.596128271065;5781.537477001872;5783.5951483396175;5791.247137872092;6221.4089661482085;6227.06594010902;6234.844128896723;6241.313455519889;6246.312905580383;5909.763609455659;5959.642421454727;5986.910196347058;6024.698765061729;6033.0347144457555;6062.363451837582;6091.786787462417;6100.054491553817;6110.602810817282;6111.266648002268;5929.762809487572;6019.969900150559;6062.939370606237;6076.908846367308;6083.330833608299;6118.877622447526;6124.326324104345;6214.533909956681;6222.595531290452;6235.781747638811;4597.632189424838;4655.6973796703105;4665.6734028617675;4691.39011928454;4696.2955556666775;4119.485064366954;4156.189543039139;4220.240356735817;4224.66202703783;4241.554636763095;5745.741441635137;5876.7649294028615;5878.059510478303;5892.057270836645;5937.2578427696535;6051.636901785907;6223.782167624111;6243.656598887014;6263.71813268404;6272.5922815016875;5668.433156684381;5743.511801496919;5744.368119506851;5895.263092113486;5926.348101708809;5361.142217245222;5375.059364611177;5402.324709411324;5413.323334583177;5420.972895135499;6303.653299068504;6326.367363263729;6343.175387199727;6352.428281454691;6361.5864968777805;5939.703014849327;6043.969780151071;6046.244219472566;6122.886104953835;6197.845053873599;6284.402981716729;6309.747610095545;6335;6336.778212762715;6352.396522330371;6046.758129674764;6062.999605065115;6076.787312444043;6083.1483592298;6092.786752463642;6053.969730151321;6118.649636126507;6128.111423843428;6173.753049877954;6222.471089957405;5968.791092311748;5981.312149102909;6030.155778190969;6037.335893051673;6088.908666370096;5822.155787410887;6000.519958403404;6042.939570604238;6048.516118710405;6048.637081775108;5851.561132914963;5907.675077870758;5926.081457374114;5942.435468630473;5982.282126144891;5932.822015339547;5937.2578427696535;5964.8807023860145;6000.279966404059;6007.309159446545;5630.971845140748;5758.913616295843;5774.220480235114;5828.475437210672;5884.7940322088525 08:52:11 INFO - 2015-12-30 08:52:11,374 DEBUG : BROWSER_OUTPUT: |1;ext.html;601.9187409699689;638.5179189711769;645.125854467197;648.3354561574384;656.2223764838664;40130;40862.38706419399;41103.588964110386;41243.38134927975;41346.37980430289;46768.2984755229;47310;47476.52523474764;47478.0504389912;47520.76239618797;9092.045335239787;9186.402883812565;9192.540372981357;9246.075392460767;9269.258459323239;9006.68476603319;9041.502717350542;9112.544372781367;9116.316276279273;9137;9114.726558203265;9123.406978546373;9171.908280917205;9174.954125229364;9206.895172579267;9071.092890710943;9116.270698344117;9123.543822808899;9127.95436022819;9140.862887056699;9062.7281181564;9186.770330741718;9208.3093767967;9208.90791092094;9248;42078.78960605208;42273.36589951153;42465.57534424678;42592.361114583306;42605.36091958623;3845.7115716321387;3888.2612303662495;4181.97909010453;4371.868843934687;4387.232234359007;31720;31843.84078079618;31947.680523194704;31968.520472192937;33147.6685233147;3810.637989391031;3876.123876123876;3933.8033098344968;3946.072672921861;4059.3707975263587;288642;290243;290542;291317;293491;46444;46929;46980;47039.29441058387;47059.76470117696;43689.56310436918;43955;44100.77949610232;44110;44192.77903610461;16729.16354182286;16890.662186756443;16950.49148525546;16951.660966780597;16982.320707171573;11699.707507312385;11785.764284714258;11793.351365674971;11827.467763950643;11864.050875930077;15581.922090389475;15664.765028524582;15704.607384815243;15704.900656954133;15759.054456732632;6273.153124328249;6389.233292004897;6448.419642232222;6462.741490340428;6527.379898909596;1037.1650821088945;1088.2327958789035;1097.4457898761075;1107.379867274329;1116.0569318925495;29960.85019574888;30236.24409389739;30252.54621180684;30393.544096838566;30491.390172196432;1072.7371793910386;1111.1166622535104;1128.3624752015085;1133.3596517967321;1159.1596092832629;14882;14973.475928342456;15146.621334466507;15549.766753498707;15550.300236489385;696704;713982;738935;740574;741421;60623.69688151531;60843.69578152081;61344.38655613476;61535.692321539;61627;1409.7814838700017;1422.1751384197141;1465.4138344662008;1536.5928029072081;1537.4234662001525;31157.221069473446;31456;31706.841465793445;31787.364252715277;32116;49389.25916111189;49494.75252623714;49860.50139498703;49909.25136123034;49948.75025624849;305065;307003;308507;309171;309610;34492.48261276033;35092.64907350894;35179.64820351764;35189.29621407506;35584.46623300601;46365.53634463612;46444.53555464402;47040.52959470498;47500.7624961873;47861.803454913905;37187;38397;38597.80701096477;39070;40124.1975160501;39006.219875602896;39396.80301598473;39549.60450395459;39726;40001;39243.60756392399;39350.60649393469;39573;39739.80130099331;39867.40198897077;33335.66664333326;33787.83106084552;34647;34648.480272796434;34733.30533389268;26736.331591710365;27535.173944781687;28652.42695146127;29270.560941585467;29728.405431891675 08:52:11 INFO - 2015-12-30 08:52:11,378 DEBUG : BROWSER_OUTPUT: |2;jquery.html;388.39022734307133;396.4509154820573;398;398.058591431265;402.1675132475775;15889.682206355896;17022.574435639086;17181.828181718178;18819.059047047645;18905.810941890595;11946.104042196848;12314.692132696664;12571.182873113241;12604.0546958978;12608.936955315234;5267.499587539178;5344.946550534503;5367.704776237305;5388.084025715618;5392.757325920343;5492.725363731817;5632.718364081779;5654.151877218409;5674.063779476382;5706.629069110515;5598.664080155183;5608.6073974821775;5708.77164913403;6299.622022678631;6302.7163777629885;6244.812655620339;6291.968540157292;6306;6319.842003949938;6327.240731112296;5191.221316802472;5321.201819727034;5328.387235467932;5344.465553444625;5677.489025987639;12962.092653514257;13140.86859131406;13166.473341066347;13447;13497.662558436019;2293.7247530296304;2320.454693147109;2321.1643808229023;2388.3909603051284;2445.7921076708503;10317.174626029975;11286;11764.058875290042;13420.731585368336;13710.588682339545;1914.731937528747;1968.3602829080462;2004.859659823813;2010.7587089549202;2014.768301645315;63140.68429657822;63454.682726586536;63802.68098659477;64606;66374;10762.40806755636;10936.179786516042;10936.671899843017;10956.726081848017;10972.835407468734;14667.266636668124;14777.261136943325;14902.478413255702;14908.403663853542;14970.70058598822;8003;8404.915950840536;8461.576921153917;8469.915300846913;8546.230839224376;8345.66617335312;8376.958115209507;8391.874121888177;8418.789530261793;8446.450980686235;4620.861374158713;4806.134895718735;4868.78090485929;4941.48114447985;4947.060058588857;1976.239147928058;2013.6742062917353;2043.6423625865414;2052.374025922078;2103.737032870891;936.3632729743839;978.5449765858909;978.9021097890154;990.7225976726528;1027.0294571629738;16706.58233544171;16736.16319184036;16906.661866762595;17348.13404379409;17357.04536250493;972.5817898303798;984.6209209454412;1005.8131404942093;1046.4296958157822;1078.8489611454402;9677.70966870995;9993.850092248622;10416.166706663449;10690.144788416908;10762.192835537366;469602;474301;597269;610498;622660;75903.62048189723;84175.57912210522;88443.55778221067;89441.55279223692;89654;490.364977354327;500.6445423749179;502.14635120295645;503.2928735127225;504.46022755651836;10430.37417754937;10479.68560943173;10635.521401537104;10763.461826908466;10794.136469082612;36551.817240913624;36744.81627591845;37971.81014094912;38367.04082397851;39488.40767388434;47044.76477617727;49492.25761613651;49660.751696241285;49767.253491196934;49903.251451228985;9678.564464598969;9818.558164882455;10039.4478303694;10400.323978941344;10504.317219380715;10999.23005389615;11248.718782030515;11275.267107637977;12268.32524211177;12402.379881006094;10684.786304273715;10929.39888306119;11102.389368584805;11165.274257173258;11217.326960382403;10834.404107773833;10868.836967445337;11010.229283950046;11039.282446640942;11054.613088541862;11360.715982100182;11454.370009649216;11663.5917742882;11666.70833229142;11719.707007324885;15048.849511504744;15495.14776687293;15638.218089095728;16121.838781612034;16587.91706041462;15935.68128637444;16067.27697253603;16080.195990200677;16182.271797768894;16222.756658650365 08:52:11 INFO - 2015-12-30 08:52:11,378 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1545.5131633535436;1560.110736879978;1797.1104303369818;1856.071964017991;1881.8964956927373;8257.463264887778;8362.91637083629;8491.78770530737;8508.787280317994;8621.39650224483;8601.397902146853;8629.87055194171;8666.783330416743;8669.349798765086;8695.86956195656;2359.6460530920326;2410.4214988402746;2410.758924107593;2413.6379543068592;2415.420299128214;2427.393151712072;2442.24290469954;2475.554400207971;2476.6408870713735;2481.3424442522746;2286.302677683306;2288.8512246703995;2315.9536809263805;2400.2079313826484;2428.368624157723;2336.1706594159;2346.143657564985;2356.4933539289136;2364.84628499147;2367.7750613691674;2418.093215044358;2448.926532204037;2451.852888826676;2452.6688896998853;2453.7178224504232;8171.305439037689;8239.340852731768;8241.8351632967;8244.134365891616;8279.089300177036;4792;4840.370751802243;4846.273059041172;4857.514248575149;4877.463479017305;3095.164305637488;3109.67348428414;3150.2754366495606;3155.4162479941056;3179.8569064391927;946.129560804062;956.9186619137312;980.4901451245383;1008.0373243552464;1009.3590569988037;10989.61536346224;11070.833937490863;11075.72310692231;11099.778004439946;11163.776724465546;4358.891027724332;4367.323064924942;4412.757298348557;4423.557644235615;4465.151621191963;9575.138237558514;9575.186109180797;9639.614415423444;9642.614295428244;9682.225421966226;4890.364252647204;4917.336159618406;4926.4088309403105;4939.2838038484215;4939.753012349368;4452.910941781146;4455.4876189238;4472.038511719996;4489.685721999429;4491.550844915482;3820;3869.3228684980018;3880.359740642819;3895.1235971906094;3903.2974064668633;1098.5166526728374;1208.4863932828512;1229.8524177098805;1236.2397125767588;1248.1387842388722;1066.0938202527943;1202.2546021466746;1214.5081242096965;1220.9206401584047;1318.7428451451874;7695.268949449794;7806.882896756553;7836.490628109154;8095.66421540451;8105.797355066053;1246.5761641041909;1250.0811903251104;1250.8186312984567;1261;1263.810428435742;6100.938990610126;6104.816855494342;6135.386461353918;6158.445739883432;6201.286852011986;10136.949315253376;10182.694519164437;10314.226433017553;10315.484225788681;10345.27583069193;9616.75958101053;10100.343477674074;10135.493225338703;10204.489775511194;10264.58941642326;7854.8821767673535;7879.2120787921895;7997.760067197877;8016;8042.195780421911;7729.497582657109;7886.369090472863;7967.880481792894;7995.720149794729;8014.158513356247;8929;8994.100589940954;9102.59038343263;9121.498317592595;9165.450072995642;9096.954515227382;9306.022867598804;9327.300452465957;9508.477033763209;9517.333786634868;7577.355924746238;7611.657475413509;7685.807854803675;7687.11598166218;7694.846103078019;8163.79590510242;8291.253787159185;8325;8349.123342048997;8356.582170891552;7721.806954826175;7740.8451830964195;7803.258690424401;7846.489978151402;7891.289783919475;6865.313468653095;7244.855102898018;7594.924050759421;7687;7709.0749110107145;7592.164861865301;7598.12621548529;7606.581638009962;7617.961910190414;7644.426668000034;6944;7004.789856304319;7036.577805331696;7047.436205103477;7086.1850887146575;6824.658767061528;6847.07564478789;6880.621565813728;6887.070245516791;6889.724411023503 08:52:11 INFO - 2015-12-30 08:52:11,381 DEBUG : BROWSER_OUTPUT: |4;prototype.html;360.73666223656744;362.41650941983403;368.6958259435966;371.32233673545784;371.61909043230696;6246.375362463751;6300.495960323175;6344.746210151594;6396.136521569587;6450.61296322221;6189.823933452641;6291.622502649844;6363.459105975986;6386.425221730044;6389.744410223586;4856.39295088114;4895.5838753705975;4900.436449808264;4911.238757992499;4914.680545764531;4915.090708218991;4919.975400123012;4925.088858561177;4929.309896614477;4929.644347804347;4714.5521175488275;4855.854324370274;4883.096627123976;4892.584130348924;4908.533689299511;4860.975695121537;4871.707697538123;4896.363472748538;4897.314375987365;4912.4350699669285;4249.936250956238;4250.53244143144;4252.55348188442;4254.212970600449;4259.31850903857;6003.519718422515;6118.653896142841;6132.877342453171;6138.508919286491;6139;5702.344230413472;5702.521461908233;5703.686297253649;5708.200851880699;5715.828525144252;6794.116764820591;6797.354251346114;6802.65986700668;6803.149606299213;6816.7614133505085;4711.952880471185;4727.361806156194;4728.38530990969;4736.905261894777;4747.83382581608;6946.409555187815;6982.1970473395195;7075.823104422379;7084.964575177142;7092.9645351772915;4864.805407783649;4867.878303042452;4869.610431165498;4871.756412179448;4880.536349046835;4922.58158056562;4926.926096108489;4946.307516947631;4947.678400904002;4950.009998000414;5618.719064046863;5673.120666296731;5707.3721890592005;5722.313322401338;5727.6849773262875;6737.831554211086;6784.287649796799;6809.727610895508;6873.243943166248;6886.552374095668;1694.2883988724766;1735.2885317020214;1739.0956702514875;1741.1207340293072;1746.580820603046;1122.1920217443428;1126.2510430563748;1136.5056200552622;1145.1583086431467;1148.724306166514;6525.64108974011;6555.508336874754;6574.211094668574;6576.243731970789;6672.499562532829;7043.401310888529;7047.788566343018;7048.083749112582;7060.71757129709;7084.220735719066;6541.2150541934325;6563.409293163638;6628.701708423133;6664.86670266592;6689.13041304637;3806.2768074066394;3834.8878825140955;3835.5972622874756;3845.750026248285;3854.0557563397147;7214.350708436266;7238.131424229126;7244.601546914865;7245.311695388929;7248.927510724825;6988.19635741886;7212.675429605575;7218.927810721931;7226.674799634029;7242.275772422716;7280.344768970818;7368.263173682696;7389.630518474055;7402.333789959037;7412.96293518529;7179;7196.136463624399;7211.531250468703;7221.819454513679;7238.746643867439;6983;7088.149422069385;7093.609851458219;7112.466565007541;7121.4302855770375;7350.52221605594;7373.820188769771;7375.151857536452;7379;7396.852062958603;4838.201696720002;4902.431222008923;4909.484504127158;4912.778924948458;4927.852164435073;7012.439004879496;7058.11773528309;7091.858162836817;7195.352418282379;7203.531770434905;6916.515843890879;6964.582125072512;6968;6976.372126508639;7008.983697363956;6907.7236910525025;6955.721771129098;6972.895406569007;6978.476614254053;6983.127109111361;6639.904415771343;6828.146481689789;6862.867626841516;6866.725330986705;6867.690953906987;6996.335348141918;7000.19497757744;7005.964970175117;7006;7014.088168538057;6656.667166641745;6833.3166683331265;6838.794836154923;6839.794806155824;6850.623215723183 08:52:11 INFO - 2015-12-30 08:52:11,382 DEBUG : BROWSER_OUTPUT: |5;yui.html;799.5043073294559;886.609891647675;935.5369092299312;942.3591957468918;958.2765012415625;12582.496700131995;12744.299063551502;12823.807642885364;12877.291748953803;12881.935590322058;12519.186252893556;12695.047871409635;12715.936420317885;12722.745545089092;12729.618111456648;903.4172958441801;907.2968449451662;908.1780988205685;909.1499448016126;909.8089401225717;890.6259371064168;903.2051794420934;904.6336233825311;905.302916754099;906.4697152165958;938.2869019545161;942.6842007927319;942.9575669094908;943.580106852451;945.475261230017;919.2921450483124;926.8470702334107;929.4237572704966;930.4138392812553;930.860370944357;698.1238545625258;700.5691499727682;701.8736627407064;702.9402500787439;703.6868593475905;12922.41849116792;13016.414261358166;13042;13072.869271307356;13088;11510.251833630871;11684.065274777997;12121.757564848742;12238.755224895542;12285.447154878051;10010.549525271308;10222.875483696787;10433.21750868688;10444.26890117692;10719.517621707042;3805.9619403805887;3841.615838416136;3860.845566177378;3870.2453021660785;3884.2231553689376;50692;50976.490235097546;51016.99999999963;51418.99999999963;51634.74182629063;9239.72280831576;9702.417854928586;9895.65365212214;10029;10052.899471005196;18158.45524634263;18791.06044697787;18895.81104188968;18899.716504252447;19028.71456928147;6705.597664140168;7104.680289386886;7187.137543494814;7314.195438501761;7629.351505122016;3823.483829682957;4120.567340429272;4180.24755544005;4243.172581346607;4285.6785741068925;3108.8134711917355;3122.09459256813;3135.890243841455;3140.591723076031;3143.387039527316;567.1917517537493;572.8023831778113;573.8909607174623;574.8476653686777;586.2291087220377;540.6053580885897;614.7264467312093;623.5011990407655;646.4085361893815;651.1242379000237;7813.374930005586;8368.41421100517;8461.153884611489;8521.403501754941;8796.252318552995;539.3581637850945;605.4006533531859;656.671664167916;662.5461558832216;673.3031312591543;3729.2355067211156;3838.3091043612417;3857;3899.8440062397185;3933.370660694275;61798.69100654558;64093.35906640967;64830.0275495868;64903;65050.67474662596;48967.51032489629;49327;50376.496235037914;50468.24297635538;50518;49290.014199715806;49512.75243623759;49801.50198498041;50706.74646626743;50794.49205507972;7732.420068494998;8135.389845761473;8612.440191387539;8616.913830861611;8622.223999840044;35034.82482587673;35532.467012995345;35695.46456803202;36055.63944360523;36284;45260.54739452563;46998.53001469941;50555.24167137422;50852.745736271085;51082.23376649279;10294.3823370598;10450.059494645518;10460.110890574386;10630.787384252426;10716.946415267874;11310.321380717183;11402.429878506207;11493.195476316578;11641.708957275798;11710.473028713557;10404.895951040393;10527.631532896312;10541.947290263499;10601.310914790514;10693;10068.69793906184;10424.166066714797;10873.945630271797;10920.399378033966;11105.555777768799;10521.210909181995;10528.210384221062;10531.947340263556;10591.046805787517;10754.73113172177;9170.770730731785;9340.206082483064;9635;9723.076307750753;9924.15644670211;8698;8964.775880602776;8988.955055224682;9004.774880628036;9104.453732776055 08:52:11 INFO - 2015-12-30 08:52:11,382 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:52:11 INFO - 2015-12-30 08:52:11,382 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:52:11 INFO - 2015-12-30 08:52:11,382 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,287 08:52:11 INFO - 2015-12-30 08:52:11,382 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:52:11 INFO - 2015-12-30 08:52:11,383 DEBUG : BROWSER_OUTPUT: __startTimestamp1451494331369__endTimestamp 08:52:11 INFO - 2015-12-30 08:52:11,383 DEBUG : BROWSER_OUTPUT: 08:52:11 INFO - 2015-12-30 08:52:11,383 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:52:11 INFO - 2015-12-30 08:52:11,384 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:52:11 INFO - 2015-12-30 08:52:11,384 DEBUG : BROWSER_OUTPUT: 08:52:11 INFO - 2015-12-30 08:52:11,384 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5682.69 Median:5926.08 stddev:627.60 (10.6%) stddev-sans-first:603.56 08:52:11 INFO - 2015-12-30 08:52:11,384 DEBUG : BROWSER_OUTPUT: Values: 3405.7 3418.5 3456.1 3467.5 3494.9 5614.1 5665.9 5732.8 5741.6 5745.6 5666.8 5676.2 5725.5 5730.2 5780.9 5188.1 5218.3 5281.6 5306.1 5310.1 5116.9 5178.7 5236.7 5244.3 5292.8 5132.2 5193.5 5195.1 5197.6 5228.1 5238.7 5248.7 5263.2 5290.7 5295.4 5048.7 5083.9 5101.7 5191.4 5191.8 5327.7 5409.5 5427.3 5448.0 5459.0 5986.3 5991.3 6008.6 6021.2 6035.7 6040.1 6092.8 6128.6 6145.1 6266.7 5762.8 5769.6 5781.5 5783.6 5791.2 6221.4 6227.1 6234.8 6241.3 6246.3 5909.8 5959.6 5986.9 6024.7 6033.0 6062.4 6091.8 6100.1 6110.6 6111.3 5929.8 6020.0 6062.9 6076.9 6083.3 6118.9 6124.3 6214.5 6222.6 6235.8 4597.6 4655.7 4665.7 4691.4 4696.3 4119.5 4156.2 4220.2 4224.7 4241.6 5745.7 5876.8 5878.1 5892.1 5937.3 6051.6 6223.8 6243.7 6263.7 6272.6 5668.4 5743.5 5744.4 5895.3 5926.3 5361.1 5375.1 5402.3 5413.3 5421.0 6303.7 6326.4 6343.2 6352.4 6361.6 5939.7 6044.0 6046.2 6122.9 6197.8 6284.4 6309.7 6335.0 6336.8 6352.4 6046.8 6063.0 6076.8 6083.1 6092.8 6054.0 6118.6 6128.1 6173.8 6222.5 5968.8 5981.3 6030.2 6037.3 6088.9 5822.2 6000.5 6042.9 6048.5 6048.6 5851.6 5907.7 5926.1 5942.4 5982.3 5932.8 5937.3 5964.9 6000.3 6007.3 5631.0 5758.9 5774.2 5828.5 5884.8 08:52:11 INFO - 2015-12-30 08:52:11,384 DEBUG : BROWSER_OUTPUT: 08:52:11 INFO - 2015-12-30 08:52:11,384 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:59394.86 Median:39649.50 stddev:130610.58 (329.4%) stddev-sans-first:130902.38 08:52:11 INFO - 2015-12-30 08:52:11,385 DEBUG : BROWSER_OUTPUT: Values: 601.9 638.5 645.1 648.3 656.2 40130.0 40862.4 41103.6 41243.4 41346.4 46768.3 47310.0 47476.5 47478.1 47520.8 9092.0 9186.4 9192.5 9246.1 9269.3 9006.7 9041.5 9112.5 9116.3 9137.0 9114.7 9123.4 9171.9 9175.0 9206.9 9071.1 9116.3 9123.5 9128.0 9140.9 9062.7 9186.8 9208.3 9208.9 9248.0 42078.8 42273.4 42465.6 42592.4 42605.4 3845.7 3888.3 4182.0 4371.9 4387.2 31720.0 31843.8 31947.7 31968.5 33147.7 3810.6 3876.1 3933.8 3946.1 4059.4 288642.0 290243.0 290542.0 291317.0 293491.0 46444.0 46929.0 46980.0 47039.3 47059.8 43689.6 43955.0 44100.8 44110.0 44192.8 16729.2 16890.7 16950.5 16951.7 16982.3 11699.7 11785.8 11793.4 11827.5 11864.1 15581.9 15664.8 15704.6 15704.9 15759.1 6273.2 6389.2 6448.4 6462.7 6527.4 1037.2 1088.2 1097.4 1107.4 1116.1 29960.9 30236.2 30252.5 30393.5 30491.4 1072.7 1111.1 1128.4 1133.4 1159.2 14882.0 14973.5 15146.6 15549.8 15550.3 696704.0 713982.0 738935.0 740574.0 741421.0 60623.7 60843.7 61344.4 61535.7 61627.0 1409.8 1422.2 1465.4 1536.6 1537.4 31157.2 31456.0 31706.8 31787.4 32116.0 49389.3 49494.8 49860.5 49909.3 49948.8 305065.0 307003.0 308507.0 309171.0 309610.0 34492.5 35092.6 35179.6 35189.3 35584.5 46365.5 46444.5 47040.5 47500.8 47861.8 37187.0 38397.0 38597.8 39070.0 40124.2 39006.2 39396.8 39549.6 39726.0 40001.0 39243.6 39350.6 39573.0 39739.8 39867.4 33335.7 33787.8 34647.0 34648.5 34733.3 26736.3 27535.2 28652.4 29270.6 29728.4 08:52:11 INFO - 2015-12-30 08:52:11,385 DEBUG : BROWSER_OUTPUT: 08:52:11 INFO - 2015-12-30 08:52:11,385 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:29368.72 Median:2307.09 stddev:91526.74 (3967.2%) stddev-sans-first:91757.63 08:52:11 INFO - 2015-12-30 08:52:11,385 DEBUG : BROWSER_OUTPUT: Values: 388.4 396.5 398.0 398.1 402.2 15889.7 17022.6 17181.8 18819.1 18905.8 11946.1 12314.7 12571.2 12604.1 12608.9 5267.5 5344.9 5367.7 5388.1 5392.8 5492.7 5632.7 5654.2 5674.1 5706.6 5598.7 5608.6 5708.8 6299.6 6302.7 6244.8 6292.0 6306.0 6319.8 6327.2 5191.2 5321.2 5328.4 5344.5 5677.5 12962.1 13140.9 13166.5 13447.0 13497.7 2293.7 2320.5 2321.2 2388.4 2445.8 10317.2 11286.0 11764.1 13420.7 13710.6 1914.7 1968.4 2004.9 2010.8 2014.8 63140.7 63454.7 63802.7 64606.0 66374.0 10762.4 10936.2 10936.7 10956.7 10972.8 14667.3 14777.3 14902.5 14908.4 14970.7 8003.0 8404.9 8461.6 8469.9 8546.2 8345.7 8377.0 8391.9 8418.8 8446.5 4620.9 4806.1 4868.8 4941.5 4947.1 1976.2 2013.7 2043.6 2052.4 2103.7 936.4 978.5 978.9 990.7 1027.0 16706.6 16736.2 16906.7 17348.1 17357.0 972.6 984.6 1005.8 1046.4 1078.8 9677.7 9993.9 10416.2 10690.1 10762.2 469602.0 474301.0 597269.0 610498.0 622660.0 75903.6 84175.6 88443.6 89441.6 89654.0 490.4 500.6 502.1 503.3 504.5 10430.4 10479.7 10635.5 10763.5 10794.1 36551.8 36744.8 37971.8 38367.0 39488.4 47044.8 49492.3 49660.8 49767.3 49903.3 9678.6 9818.6 10039.4 10400.3 10504.3 10999.2 11248.7 11275.3 12268.3 12402.4 10684.8 10929.4 11102.4 11165.3 11217.3 10834.4 10868.8 11010.2 11039.3 11054.6 11360.7 11454.4 11663.6 11666.7 11719.7 15048.8 15495.1 15638.2 16121.8 16587.9 15935.7 16067.3 16080.2 16182.3 16222.8 08:52:11 INFO - 2015-12-30 08:52:11,386 DEBUG : BROWSER_OUTPUT: 08:52:11 INFO - 2015-12-30 08:52:11,386 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5872.34 Median:5520.35 stddev:3070.92 (55.6%) stddev-sans-first:3062.32 08:52:11 INFO - 2015-12-30 08:52:11,387 DEBUG : BROWSER_OUTPUT: Values: 1545.5 1560.1 1797.1 1856.1 1881.9 8257.5 8362.9 8491.8 8508.8 8621.4 8601.4 8629.9 8666.8 8669.3 8695.9 2359.6 2410.4 2410.8 2413.6 2415.4 2427.4 2442.2 2475.6 2476.6 2481.3 2286.3 2288.9 2316.0 2400.2 2428.4 2336.2 2346.1 2356.5 2364.8 2367.8 2418.1 2448.9 2451.9 2452.7 2453.7 8171.3 8239.3 8241.8 8244.1 8279.1 4792.0 4840.4 4846.3 4857.5 4877.5 3095.2 3109.7 3150.3 3155.4 3179.9 946.1 956.9 980.5 1008.0 1009.4 10989.6 11070.8 11075.7 11099.8 11163.8 4358.9 4367.3 4412.8 4423.6 4465.2 9575.1 9575.2 9639.6 9642.6 9682.2 4890.4 4917.3 4926.4 4939.3 4939.8 4452.9 4455.5 4472.0 4489.7 4491.6 3820.0 3869.3 3880.4 3895.1 3903.3 1098.5 1208.5 1229.9 1236.2 1248.1 1066.1 1202.3 1214.5 1220.9 1318.7 7695.3 7806.9 7836.5 8095.7 8105.8 1246.6 1250.1 1250.8 1261.0 1263.8 6100.9 6104.8 6135.4 6158.4 6201.3 10136.9 10182.7 10314.2 10315.5 10345.3 9616.8 10100.3 10135.5 10204.5 10264.6 7854.9 7879.2 7997.8 8016.0 8042.2 7729.5 7886.4 7967.9 7995.7 8014.2 8929.0 8994.1 9102.6 9121.5 9165.5 9097.0 9306.0 9327.3 9508.5 9517.3 7577.4 7611.7 7685.8 7687.1 7694.8 8163.8 8291.3 8325.0 8349.1 8356.6 7721.8 7740.8 7803.3 7846.5 7891.3 6865.3 7244.9 7594.9 7687.0 7709.1 7592.2 7598.1 7606.6 7618.0 7644.4 6944.0 7004.8 7036.6 7047.4 7086.2 6824.7 6847.1 6880.6 6887.1 6889.7 08:52:11 INFO - 2015-12-30 08:52:11,387 DEBUG : BROWSER_OUTPUT: 08:52:11 INFO - 2015-12-30 08:52:11,387 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5736.60 Median:6533.43 stddev:1740.56 (26.6%) stddev-sans-first:1698.03 08:52:11 INFO - 2015-12-30 08:52:11,387 DEBUG : BROWSER_OUTPUT: Values: 360.7 362.4 368.7 371.3 371.6 6246.4 6300.5 6344.7 6396.1 6450.6 6189.8 6291.6 6363.5 6386.4 6389.7 4856.4 4895.6 4900.4 4911.2 4914.7 4915.1 4920.0 4925.1 4929.3 4929.6 4714.6 4855.9 4883.1 4892.6 4908.5 4861.0 4871.7 4896.4 4897.3 4912.4 4249.9 4250.5 4252.6 4254.2 4259.3 6003.5 6118.7 6132.9 6138.5 6139.0 5702.3 5702.5 5703.7 5708.2 5715.8 6794.1 6797.4 6802.7 6803.1 6816.8 4712.0 4727.4 4728.4 4736.9 4747.8 6946.4 6982.2 7075.8 7085.0 7093.0 4864.8 4867.9 4869.6 4871.8 4880.5 4922.6 4926.9 4946.3 4947.7 4950.0 5618.7 5673.1 5707.4 5722.3 5727.7 6737.8 6784.3 6809.7 6873.2 6886.6 1694.3 1735.3 1739.1 1741.1 1746.6 1122.2 1126.3 1136.5 1145.2 1148.7 6525.6 6555.5 6574.2 6576.2 6672.5 7043.4 7047.8 7048.1 7060.7 7084.2 6541.2 6563.4 6628.7 6664.9 6689.1 3806.3 3834.9 3835.6 3845.8 3854.1 7214.4 7238.1 7244.6 7245.3 7248.9 6988.2 7212.7 7218.9 7226.7 7242.3 7280.3 7368.3 7389.6 7402.3 7413.0 7179.0 7196.1 7211.5 7221.8 7238.7 6983.0 7088.1 7093.6 7112.5 7121.4 7350.5 7373.8 7375.2 7379.0 7396.9 4838.2 4902.4 4909.5 4912.8 4927.9 7012.4 7058.1 7091.9 7195.4 7203.5 6916.5 6964.6 6968.0 6976.4 7009.0 6907.7 6955.7 6972.9 6978.5 6983.1 6639.9 6828.1 6862.9 6866.7 6867.7 6996.3 7000.2 7006.0 7006.0 7014.1 6656.7 6833.3 6838.8 6839.8 6850.6 08:52:11 INFO - 2015-12-30 08:52:11,387 DEBUG : BROWSER_OUTPUT: 08:52:11 INFO - 2015-12-30 08:52:11,388 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14100.24 Median:50493.12 stddev:17082.23 (33.8%) stddev-sans-first:17100.95 08:52:11 INFO - 2015-12-30 08:52:11,389 DEBUG : BROWSER_OUTPUT: Values: 799.5 886.6 935.5 942.4 958.3 12582.5 12744.3 12823.8 12877.3 12881.9 12519.2 12695.0 12715.9 12722.7 12729.6 903.4 907.3 908.2 909.1 909.8 890.6 903.2 904.6 905.3 906.5 938.3 942.7 943.0 943.6 945.5 919.3 926.8 929.4 930.4 930.9 698.1 700.6 701.9 702.9 703.7 12922.4 13016.4 13042.0 13072.9 13088.0 11510.3 11684.1 12121.8 12238.8 12285.4 10010.5 10222.9 10433.2 10444.3 10719.5 3806.0 3841.6 3860.8 3870.2 3884.2 50692.0 50976.5 51017.0 51419.0 51634.7 9239.7 9702.4 9895.7 10029.0 10052.9 18158.5 18791.1 18895.8 18899.7 19028.7 6705.6 7104.7 7187.1 7314.2 7629.4 3823.5 4120.6 4180.2 4243.2 4285.7 3108.8 3122.1 3135.9 3140.6 3143.4 567.2 572.8 573.9 574.8 586.2 540.6 614.7 623.5 646.4 651.1 7813.4 8368.4 8461.2 8521.4 8796.3 539.4 605.4 656.7 662.5 673.3 3729.2 3838.3 3857.0 3899.8 3933.4 61798.7 64093.4 64830.0 64903.0 65050.7 48967.5 49327.0 50376.5 50468.2 50518.0 49290.0 49512.8 49801.5 50706.7 50794.5 7732.4 8135.4 8612.4 8616.9 8622.2 35034.8 35532.5 35695.5 36055.6 36284.0 45260.5 46998.5 50555.2 50852.7 51082.2 10294.4 10450.1 10460.1 10630.8 10716.9 11310.3 11402.4 11493.2 11641.7 11710.5 10404.9 10527.6 10541.9 10601.3 10693.0 10068.7 10424.2 10873.9 10920.4 11105.6 10521.2 10528.2 10531.9 10591.0 10754.7 9170.8 9340.2 9635.0 9723.1 9924.2 8698.0 8964.8 8989.0 9004.8 9104.5 08:52:11 INFO - 2015-12-30 08:52:11,389 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:52:11 INFO - 2015-12-30 08:52:11,389 DEBUG : BROWSER_OUTPUT: 08:52:12 INFO - 2015-12-30 08:52:12,085 INFO : Browser exited with error code: 0 08:52:12 INFO - 2015-12-30 08:52:12,107 INFO : Completed test dromaeo_css (00:18:29) 08:52:12 INFO - 2015-12-30 08:52:12,107 INFO : Starting test kraken 08:52:12 INFO - 2015-12-30 08:52:12,107 DEBUG : operating with platform_type : linux_ 08:52:12 INFO - 2015-12-30 08:52:12,107 INFO : Initialising browser for kraken test... 08:52:12 INFO - 2015-12-30 08:52:12,113 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpw6emI6/profile http://localhost:35769/getInfo.html 08:52:17 INFO - 2015-12-30 08:52:17,049 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:52:17 INFO - 2015-12-30 08:52:17,050 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:52:17 INFO - 2015-12-30 08:52:17,050 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:52:17 INFO - 2015-12-30 08:52:17,050 DEBUG : BROWSER_OUTPUT: __metrics 08:52:18 INFO - 2015-12-30 08:52:18,125 INFO : Browser initialized. 08:52:18 INFO - 2015-12-30 08:52:18,126 INFO : Running cycle 1/1 for kraken test... 08:52:18 INFO - 2015-12-30 08:52:18,126 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpw6emI6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:52:29 INFO - 2015-12-30 08:52:29,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 136437760 08:52:29 INFO - 2015-12-30 08:52:29,884 DEBUG : BROWSER_OUTPUT: 08:52:32 INFO - 2015-12-30 08:52:32,341 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35769/tests/kraken/driver.html?testName=audio-beat-detection) 08:52:32 INFO - 2015-12-30 08:52:32,955 DEBUG : BROWSER_OUTPUT: RSS: Main: 137646080 08:52:32 INFO - 2015-12-30 08:52:32,955 DEBUG : BROWSER_OUTPUT: 08:52:35 INFO - 2015-12-30 08:52:35,566 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35769/tests/kraken/driver.html?testName=audio-dft) 08:52:36 INFO - 2015-12-30 08:52:36,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 138272768 08:52:36 INFO - 2015-12-30 08:52:36,152 DEBUG : BROWSER_OUTPUT: 08:52:38 INFO - 2015-12-30 08:52:38,991 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35769/tests/kraken/driver.html?testName=audio-fft) 08:52:39 INFO - 2015-12-30 08:52:39,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 139173888 08:52:39 INFO - 2015-12-30 08:52:39,573 DEBUG : BROWSER_OUTPUT: 08:52:41 INFO - 2015-12-30 08:52:41,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35769/tests/kraken/driver.html?testName=audio-oscillator) 08:52:42 INFO - 2015-12-30 08:52:42,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 138207232 08:52:42 INFO - 2015-12-30 08:52:42,179 DEBUG : BROWSER_OUTPUT: 08:52:44 INFO - 2015-12-30 08:52:44,379 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35769/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:52:44 INFO - 2015-12-30 08:52:44,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 138883072 08:52:44 INFO - 2015-12-30 08:52:44,960 DEBUG : BROWSER_OUTPUT: 08:52:47 INFO - 2015-12-30 08:52:47,932 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35769/tests/kraken/driver.html?testName=imaging-darkroom) 08:52:48 INFO - 2015-12-30 08:52:48,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 137134080 08:52:48 INFO - 2015-12-30 08:52:48,518 DEBUG : BROWSER_OUTPUT: 08:52:51 INFO - 2015-12-30 08:52:51,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35769/tests/kraken/driver.html?testName=imaging-desaturate) 08:52:52 INFO - 2015-12-30 08:52:52,440 DEBUG : BROWSER_OUTPUT: RSS: Main: 137289728 08:52:52 INFO - 2015-12-30 08:52:52,440 DEBUG : BROWSER_OUTPUT: 08:52:55 INFO - 2015-12-30 08:52:55,199 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35769/tests/kraken/driver.html?testName=json-parse-financial) 08:52:55 INFO - 2015-12-30 08:52:55,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 138571776 08:52:55 INFO - 2015-12-30 08:52:55,801 DEBUG : BROWSER_OUTPUT: 08:52:57 INFO - 2015-12-30 08:52:57,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35769/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:52:57 INFO - 2015-12-30 08:52:57,963 DEBUG : BROWSER_OUTPUT: RSS: Main: 138612736 08:52:57 INFO - 2015-12-30 08:52:57,964 DEBUG : BROWSER_OUTPUT: 08:52:59 INFO - 2015-12-30 08:52:59,715 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35769/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:53:00 INFO - 2015-12-30 08:53:00,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 139153408 08:53:00 INFO - 2015-12-30 08:53:00,330 DEBUG : BROWSER_OUTPUT: 08:53:02 INFO - 2015-12-30 08:53:02,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35769/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:53:02 INFO - 2015-12-30 08:53:02,953 DEBUG : BROWSER_OUTPUT: RSS: Main: 139661312 08:53:02 INFO - 2015-12-30 08:53:02,953 DEBUG : BROWSER_OUTPUT: 08:53:05 INFO - 2015-12-30 08:53:05,348 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:53:05 INFO - 2015-12-30 08:53:05,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 137838592 08:53:05 INFO - 2015-12-30 08:53:05,952 DEBUG : BROWSER_OUTPUT: 08:53:08 INFO - 2015-12-30 08:53:08,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:53:09 INFO - 2015-12-30 08:53:09,061 DEBUG : BROWSER_OUTPUT: RSS: Main: 138379264 08:53:09 INFO - 2015-12-30 08:53:09,062 DEBUG : BROWSER_OUTPUT: 08:53:10 INFO - 2015-12-30 08:53:10,695 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35769/tests/kraken/driver.html?testName=ai-astar) 08:53:10 INFO - 2015-12-30 08:53:10,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 138727424 08:53:10 INFO - 2015-12-30 08:53:10,946 DEBUG : BROWSER_OUTPUT: 08:53:10 INFO - 2015-12-30 08:53:10,949 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:53:10 INFO - 2015-12-30 08:53:10,949 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:53:10 INFO - 2015-12-30 08:53:10,949 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:53:10 INFO - 2015-12-30 08:53:10,949 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:53:10 INFO - 2015-12-30 08:53:10,949 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;105;112;112;111;122;120;111;112;112 08:53:10 INFO - 2015-12-30 08:53:10,950 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;133;153;152;123;153;157;125;171;125 08:53:10 INFO - 2015-12-30 08:53:10,950 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;162;162;164;163;166;161;163;163 08:53:10 INFO - 2015-12-30 08:53:10,950 DEBUG : BROWSER_OUTPUT: |3;audio-fft;81;73;72;160;80;71;72;74;159;72 08:53:10 INFO - 2015-12-30 08:53:10,950 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;148;93;93;93;137;93;93;133 08:53:10 INFO - 2015-12-30 08:53:10,950 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;110;110;109;112;110;109;110 08:53:10 INFO - 2015-12-30 08:53:10,950 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;151;147;147;146;147;146;148;147;147;146 08:53:10 INFO - 2015-12-30 08:53:10,950 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;97;97;97;96;95 08:53:10 INFO - 2015-12-30 08:53:10,950 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;58;62;61;60;60;63;60;62;58;61 08:53:10 INFO - 2015-12-30 08:53:10,950 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;64;66;64;65;65;64;64;64;65;64 08:53:10 INFO - 2015-12-30 08:53:10,950 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;81;82;82;90;82;82;81;81;89 08:53:10 INFO - 2015-12-30 08:53:10,951 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;112;111;121;120;111;121;128;128;115;115 08:53:10 INFO - 2015-12-30 08:53:10,951 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;147;144;156;147;144;142;143;145;143 08:53:10 INFO - 2015-12-30 08:53:10,951 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;68;66;65;66;65;66;64;63 08:53:10 INFO - 2015-12-30 08:53:10,951 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:53:10 INFO - 2015-12-30 08:53:10,951 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:53:10 INFO - 2015-12-30 08:53:10,951 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,692 08:53:10 INFO - 2015-12-30 08:53:10,951 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:53:10 INFO - 2015-12-30 08:53:10,951 DEBUG : BROWSER_OUTPUT: __startTimestamp1451494390947__endTimestamp 08:53:10 INFO - 2015-12-30 08:53:10,951 DEBUG : BROWSER_OUTPUT: 08:53:10 INFO - 2015-12-30 08:53:10,953 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:53:10 INFO - 2015-12-30 08:53:10,953 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:53:10 INFO - 2015-12-30 08:53:10,953 DEBUG : BROWSER_OUTPUT: 08:53:10 INFO - 2015-12-30 08:53:10,953 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.80 Median:112.00 stddev:4.83 (4.3%) stddev-sans-first:5.07 08:53:10 INFO - 2015-12-30 08:53:10,953 DEBUG : BROWSER_OUTPUT: Values: 111.0 105.0 112.0 112.0 111.0 122.0 120.0 111.0 112.0 112.0 08:53:10 INFO - 2015-12-30 08:53:10,953 DEBUG : BROWSER_OUTPUT: 08:53:10 INFO - 2015-12-30 08:53:10,953 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.20 Median:152.50 stddev:16.48 (10.8%) stddev-sans-first:17.34 08:53:10 INFO - 2015-12-30 08:53:10,953 DEBUG : BROWSER_OUTPUT: Values: 150.0 133.0 153.0 152.0 123.0 153.0 157.0 125.0 171.0 125.0 08:53:10 INFO - 2015-12-30 08:53:10,954 DEBUG : BROWSER_OUTPUT: 08:53:10 INFO - 2015-12-30 08:53:10,954 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.80 Median:163.00 stddev:1.40 (0.9%) stddev-sans-first:1.45 08:53:10 INFO - 2015-12-30 08:53:10,954 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 162.0 162.0 164.0 163.0 166.0 161.0 163.0 163.0 08:53:10 INFO - 2015-12-30 08:53:10,954 DEBUG : BROWSER_OUTPUT: 08:53:10 INFO - 2015-12-30 08:53:10,954 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:91.40 Median:72.50 stddev:36.06 (49.7%) stddev-sans-first:38.05 08:53:10 INFO - 2015-12-30 08:53:10,954 DEBUG : BROWSER_OUTPUT: Values: 81.0 73.0 72.0 160.0 80.0 71.0 72.0 74.0 159.0 72.0 08:53:10 INFO - 2015-12-30 08:53:10,954 DEBUG : BROWSER_OUTPUT: 08:53:10 INFO - 2015-12-30 08:53:10,955 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.90 Median:93.00 stddev:22.68 (24.4%) stddev-sans-first:23.49 08:53:10 INFO - 2015-12-30 08:53:10,955 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 148.0 93.0 93.0 93.0 137.0 93.0 93.0 133.0 08:53:10 INFO - 2015-12-30 08:53:10,955 DEBUG : BROWSER_OUTPUT: 08:53:10 INFO - 2015-12-30 08:53:10,955 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.95 (0.9%) stddev-sans-first:0.97 08:53:10 INFO - 2015-12-30 08:53:10,956 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 110.0 110.0 109.0 112.0 110.0 109.0 110.0 08:53:10 INFO - 2015-12-30 08:53:10,956 DEBUG : BROWSER_OUTPUT: 08:53:10 INFO - 2015-12-30 08:53:10,956 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.48 (1.0%) stddev-sans-first:0.67 08:53:10 INFO - 2015-12-30 08:53:10,956 DEBUG : BROWSER_OUTPUT: Values: 151.0 147.0 147.0 146.0 147.0 146.0 148.0 147.0 147.0 146.0 08:53:10 INFO - 2015-12-30 08:53:10,956 DEBUG : BROWSER_OUTPUT: 08:53:10 INFO - 2015-12-30 08:53:10,956 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:53:10 INFO - 2015-12-30 08:53:10,957 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 97.0 97.0 97.0 96.0 95.0 08:53:10 INFO - 2015-12-30 08:53:10,957 DEBUG : BROWSER_OUTPUT: 08:53:10 INFO - 2015-12-30 08:53:10,957 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:60.50 Median:61.00 stddev:1.65 (2.7%) stddev-sans-first:1.48 08:53:10 INFO - 2015-12-30 08:53:10,957 DEBUG : BROWSER_OUTPUT: Values: 58.0 62.0 61.0 60.0 60.0 63.0 60.0 62.0 58.0 61.0 08:53:10 INFO - 2015-12-30 08:53:10,957 DEBUG : BROWSER_OUTPUT: 08:53:10 INFO - 2015-12-30 08:53:10,957 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:64.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 08:53:10 INFO - 2015-12-30 08:53:10,957 DEBUG : BROWSER_OUTPUT: Values: 64.0 66.0 64.0 65.0 65.0 64.0 64.0 64.0 65.0 64.0 08:53:10 INFO - 2015-12-30 08:53:10,958 DEBUG : BROWSER_OUTPUT: 08:53:10 INFO - 2015-12-30 08:53:10,958 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.00 stddev:3.41 (4.2%) stddev-sans-first:3.54 08:53:10 INFO - 2015-12-30 08:53:10,958 DEBUG : BROWSER_OUTPUT: Values: 81.0 81.0 82.0 82.0 90.0 82.0 82.0 81.0 81.0 89.0 08:53:10 INFO - 2015-12-30 08:53:10,958 DEBUG : BROWSER_OUTPUT: 08:53:10 INFO - 2015-12-30 08:53:10,958 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.20 Median:120.50 stddev:6.44 (5.3%) stddev-sans-first:6.43 08:53:10 INFO - 2015-12-30 08:53:10,958 DEBUG : BROWSER_OUTPUT: Values: 112.0 111.0 121.0 120.0 111.0 121.0 128.0 128.0 115.0 115.0 08:53:10 INFO - 2015-12-30 08:53:10,958 DEBUG : BROWSER_OUTPUT: 08:53:10 INFO - 2015-12-30 08:53:10,958 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:144.50 stddev:4.09 (2.8%) stddev-sans-first:4.24 08:53:10 INFO - 2015-12-30 08:53:10,959 DEBUG : BROWSER_OUTPUT: Values: 143.0 147.0 144.0 156.0 147.0 144.0 142.0 143.0 145.0 143.0 08:53:10 INFO - 2015-12-30 08:53:10,959 DEBUG : BROWSER_OUTPUT: 08:53:10 INFO - 2015-12-30 08:53:10,959 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.62 (2.5%) stddev-sans-first:1.51 08:53:10 INFO - 2015-12-30 08:53:10,959 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 68.0 66.0 65.0 66.0 65.0 66.0 64.0 63.0 08:53:10 INFO - 2015-12-30 08:53:10,959 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:53:10 INFO - 2015-12-30 08:53:10,959 DEBUG : BROWSER_OUTPUT: 08:53:12 INFO - 2015-12-30 08:53:12,093 INFO : Browser exited with error code: 0 08:53:12 INFO - 2015-12-30 08:53:12,144 INFO : Completed test kraken (00:01:00) 08:53:12 INFO - 2015-12-30 08:53:12,144 INFO : Starting test v8_7 08:53:12 INFO - 2015-12-30 08:53:12,144 DEBUG : operating with platform_type : linux_ 08:53:12 INFO - 2015-12-30 08:53:12,145 INFO : Initialising browser for v8_7 test... 08:53:12 INFO - 2015-12-30 08:53:12,151 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxvK5zE/profile http://localhost:35769/getInfo.html 08:53:17 INFO - 2015-12-30 08:53:17,197 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:53:17 INFO - 2015-12-30 08:53:17,198 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:53:17 INFO - 2015-12-30 08:53:17,198 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:53:17 INFO - 2015-12-30 08:53:17,198 DEBUG : BROWSER_OUTPUT: __metrics 08:53:18 INFO - 2015-12-30 08:53:18,133 INFO : Browser initialized. 08:53:18 INFO - 2015-12-30 08:53:18,134 INFO : Running cycle 1/1 for v8_7 test... 08:53:18 INFO - 2015-12-30 08:53:18,134 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxvK5zE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:53:29 INFO - 2015-12-30 08:53:29,942 DEBUG : BROWSER_OUTPUT: RSS: Main: 137027584 08:53:29 INFO - 2015-12-30 08:53:29,943 DEBUG : BROWSER_OUTPUT: 08:53:51 INFO - 2015-12-30 08:53:51,292 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:35769/tests/v8_7/run.html (next: http://localhost:35769/tests/v8_7/run.html) 08:53:51 INFO - 2015-12-30 08:53:51,542 DEBUG : BROWSER_OUTPUT: RSS: Main: 136081408 08:53:51 INFO - 2015-12-30 08:53:51,543 DEBUG : BROWSER_OUTPUT: 08:53:51 INFO - 2015-12-30 08:53:51,543 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:53:51 INFO - 2015-12-30 08:53:51,543 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:53:51 INFO - 2015-12-30 08:53:51,543 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:53:51 INFO - 2015-12-30 08:53:51,544 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:53:51 INFO - 2015-12-30 08:53:51,544 DEBUG : BROWSER_OUTPUT: |0;Richards;166.19577862722286 08:53:51 INFO - 2015-12-30 08:53:51,544 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;173.58097552508247 08:53:51 INFO - 2015-12-30 08:53:51,544 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.56569652444193 08:53:51 INFO - 2015-12-30 08:53:51,545 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 08:53:51 INFO - 2015-12-30 08:53:51,545 DEBUG : BROWSER_OUTPUT: |4;RayTrace;925.925925925926 08:53:51 INFO - 2015-12-30 08:53:51,546 DEBUG : BROWSER_OUTPUT: |5;Earley;545.5537370430987 08:53:51 INFO - 2015-12-30 08:53:51,546 DEBUG : BROWSER_OUTPUT: |6;Boyer;11131.868131868132 08:53:51 INFO - 2015-12-30 08:53:51,546 DEBUG : BROWSER_OUTPUT: |7;RegExp;24261.904761904763 08:53:51 INFO - 2015-12-30 08:53:51,546 DEBUG : BROWSER_OUTPUT: |8;Splay;529.1005291005291 08:53:51 INFO - 2015-12-30 08:53:51,547 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 08:53:51 INFO - 2015-12-30 08:53:51,547 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:53:51 INFO - 2015-12-30 08:53:51,547 DEBUG : BROWSER_OUTPUT: __startTimestamp1451494431542__endTimestamp 08:53:51 INFO - 2015-12-30 08:53:51,547 DEBUG : BROWSER_OUTPUT: 08:53:51 INFO - 2015-12-30 08:53:51,547 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:53:51 INFO - 2015-12-30 08:53:51,547 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:53:51 INFO - 2015-12-30 08:53:51,547 DEBUG : BROWSER_OUTPUT: 08:53:51 INFO - 2015-12-30 08:53:51,547 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.20 Median:166.20 stddev:0.00 (0.0%) 08:53:51 INFO - 2015-12-30 08:53:51,547 DEBUG : BROWSER_OUTPUT: Values: 166.2 08:53:51 INFO - 2015-12-30 08:53:51,548 DEBUG : BROWSER_OUTPUT: 08:53:51 INFO - 2015-12-30 08:53:51,548 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:173.58 Median:173.58 stddev:0.00 (0.0%) 08:53:51 INFO - 2015-12-30 08:53:51,548 DEBUG : BROWSER_OUTPUT: Values: 173.6 08:53:51 INFO - 2015-12-30 08:53:51,548 DEBUG : BROWSER_OUTPUT: 08:53:51 INFO - 2015-12-30 08:53:51,549 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.57 Median:282.57 stddev:0.00 (0.0%) 08:53:51 INFO - 2015-12-30 08:53:51,549 DEBUG : BROWSER_OUTPUT: Values: 282.6 08:53:51 INFO - 2015-12-30 08:53:51,549 DEBUG : BROWSER_OUTPUT: 08:53:51 INFO - 2015-12-30 08:53:51,549 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 08:53:51 INFO - 2015-12-30 08:53:51,549 DEBUG : BROWSER_OUTPUT: Values: 5181.3 08:53:51 INFO - 2015-12-30 08:53:51,550 DEBUG : BROWSER_OUTPUT: 08:53:51 INFO - 2015-12-30 08:53:51,550 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:925.93 Median:925.93 stddev:0.00 (0.0%) 08:53:51 INFO - 2015-12-30 08:53:51,550 DEBUG : BROWSER_OUTPUT: Values: 925.9 08:53:51 INFO - 2015-12-30 08:53:51,550 DEBUG : BROWSER_OUTPUT: 08:53:51 INFO - 2015-12-30 08:53:51,551 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:545.55 Median:545.55 stddev:0.00 (0.0%) 08:53:51 INFO - 2015-12-30 08:53:51,551 DEBUG : BROWSER_OUTPUT: Values: 545.6 08:53:51 INFO - 2015-12-30 08:53:51,551 DEBUG : BROWSER_OUTPUT: 08:53:51 INFO - 2015-12-30 08:53:51,551 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11131.87 Median:11131.87 stddev:0.00 (0.0%) 08:53:51 INFO - 2015-12-30 08:53:51,551 DEBUG : BROWSER_OUTPUT: Values: 11131.9 08:53:51 INFO - 2015-12-30 08:53:51,551 DEBUG : BROWSER_OUTPUT: 08:53:51 INFO - 2015-12-30 08:53:51,551 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24261.90 Median:24261.90 stddev:0.00 (0.0%) 08:53:51 INFO - 2015-12-30 08:53:51,551 DEBUG : BROWSER_OUTPUT: Values: 24261.9 08:53:51 INFO - 2015-12-30 08:53:51,552 DEBUG : BROWSER_OUTPUT: 08:53:51 INFO - 2015-12-30 08:53:51,552 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:529.10 Median:529.10 stddev:0.00 (0.0%) 08:53:51 INFO - 2015-12-30 08:53:51,552 DEBUG : BROWSER_OUTPUT: Values: 529.1 08:53:51 INFO - 2015-12-30 08:53:51,552 DEBUG : BROWSER_OUTPUT: 08:53:51 INFO - 2015-12-30 08:53:51,552 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 08:53:51 INFO - 2015-12-30 08:53:51,553 DEBUG : BROWSER_OUTPUT: Values: 4826.9 08:53:51 INFO - 2015-12-30 08:53:51,553 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:53:51 INFO - 2015-12-30 08:53:51,553 DEBUG : BROWSER_OUTPUT: 08:53:52 INFO - 2015-12-30 08:53:52,457 INFO : Browser exited with error code: 0 08:53:52 INFO - 2015-12-30 08:53:52,472 INFO : Completed test v8_7 (00:00:40) 08:53:52 INFO - 2015-12-30 08:53:52,595 INFO : Completed test suite (00:20:09) 08:53:52 INFO - 2015-12-30 08:53:52,595 DEBUG : Working with test: dromaeo_css 08:53:52 INFO - 2015-12-30 08:53:52,596 DEBUG : Generating results file: dromaeo_css 08:53:52 INFO - 2015-12-30 08:53:52,597 DEBUG : Working with test: kraken 08:53:52 INFO - 2015-12-30 08:53:52,597 DEBUG : Generating results file: kraken 08:53:52 INFO - 2015-12-30 08:53:52,597 INFO : javascript benchmark 08:53:52 INFO - 2015-12-30 08:53:52,597 DEBUG : Working with test: v8_7 08:53:52 INFO - 2015-12-30 08:53:52,597 DEBUG : Generating results file: v8_7 08:53:52 INFO - 2015-12-30 08:53:52,598 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:53:52 INFO - 2015-12-30 08:53:52,656 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 08:53:52 INFO - 2015-12-30 08:53:52,656 DEBUG : process_Request line: dromaeo_css 7319.24 graph.html#tests=[[72,52,43]] 08:53:52 INFO - 2015-12-30 08:53:52,656 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:53:52 INFO - 2015-12-30 08:53:52,696 DEBUG : process_Request line: kraken 1508.70 graph.html#tests=[[232,52,43]] 08:53:52 INFO - 2015-12-30 08:53:52,697 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:53:52 INFO - 2015-12-30 08:53:52,727 DEBUG : process_Request line: v8_7 23048.59 graph.html#tests=[[230,52,43]] 08:53:52 INFO - 2015-12-30 08:53:52,729 INFO : javascript benchmark 08:53:52 INFO - 2015-12-30 08:53:52,732 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3405.659434056594, 3418.5214070030215, 3456.118689734119, 3467.49721290413, 3494.930101397972, 5614.1298098794705, 5665.943340566593, 5732.79935202268, 5741.569382296324, 5745.5690823188215, 5666.801661941833, 5676.205331253628, 5725.541956643469, 5730.197772311869, 5780.884382312352, 5188.143956247215, 5218.347706536683, 5281.5774738021055, 5306.124489459235, 5310.123829568117, 5116.872078198037, 5178.689278643294, 5236.7119808410525, 5244.318238628973, 5292.761825717852, 5132.204508301219, 5193.506616871391, 5195.116830138885, 5197.558207552343, 5228.0850851101095, 5238.685678859261, 5248.6588371755715, 5263.210518422229, 5290.735463226862, 5295.364556253236, 5048.697078175322, 5083.949160508385, 5101.744912754384, 5191.428942816287, 5191.8182863599595, 5327.680339179662, 5409.459054094559, 5427.267318911936, 5447.972760136214, 5458.972705136489, 5986.341502434729, 5991.281046274431, 6008.579399442041, 6021.2473440819895, 6035.7283922223605, 6040.0939859021055, 6092.847678808065, 6128.594790794166, 6145.0782382642965, 6266.717997690115, 5762.798302059449, 5769.596128271065, 5781.537477001872, 5783.5951483396175, 5791.247137872092, 6221.4089661482085, 6227.06594010902, 6234.844128896723, 6241.313455519889, 6246.312905580383, 5909.763609455659, 5959.642421454727, 5986.910196347058, 6024.698765061729, 6033.0347144457555, 6062.363451837582, 6091.786787462417, 6100.054491553817, 6110.602810817282, 6111.266648002268, 5929.762809487572, 6019.969900150559, 6062.939370606237, 6076.908846367308, 6083.330833608299, 6118.877622447526, 6124.326324104345, 6214.533909956681, 6222.595531290452, 6235.781747638811, 4597.632189424838, 4655.6973796703105, 4665.6734028617675, 4691.39011928454, 4696.2955556666775, 4119.485064366954, 4156.189543039139, 4220.240356735817, 4224.66202703783, 4241.554636763095, 5745.741441635137, 5876.7649294028615, 5878.059510478303, 5892.057270836645, 5937.2578427696535, 6051.636901785907, 6223.782167624111, 6243.656598887014, 6263.71813268404, 6272.5922815016875, 5668.433156684381, 5743.511801496919, 5744.368119506851, 5895.263092113486, 5926.348101708809, 5361.142217245222, 5375.059364611177, 5402.324709411324, 5413.323334583177, 5420.972895135499, 6303.653299068504, 6326.367363263729, 6343.175387199727, 6352.428281454691, 6361.5864968777805, 5939.703014849327, 6043.969780151071, 6046.244219472566, 6122.886104953835, 6197.845053873599, 6284.402981716729, 6309.747610095545, 6335.0, 6336.778212762715, 6352.396522330371, 6046.758129674764, 6062.999605065115, 6076.787312444043, 6083.1483592298, 6092.786752463642, 6053.969730151321, 6118.649636126507, 6128.111423843428, 6173.753049877954, 6222.471089957405, 5968.791092311748, 5981.312149102909, 6030.155778190969, 6037.335893051673, 6088.908666370096, 5822.155787410887, 6000.519958403404, 6042.939570604238, 6048.516118710405, 6048.637081775108, 5851.561132914963, 5907.675077870758, 5926.081457374114, 5942.435468630473, 5982.282126144891, 5932.822015339547, 5937.2578427696535, 5964.8807023860145, 6000.279966404059, 6007.309159446545, 5630.971845140748, 5758.913616295843, 5774.220480235114, 5828.475437210672, 5884.7940322088525], "unit": "ms", "name": "dojo.html", "value": 5642.216691676355}, {"lowerIsBetter": false, "replicates": [601.9187409699689, 638.5179189711769, 645.125854467197, 648.3354561574384, 656.2223764838664, 40130.0, 40862.38706419399, 41103.588964110386, 41243.38134927975, 41346.37980430289, 46768.2984755229, 47310.0, 47476.52523474764, 47478.0504389912, 47520.76239618797, 9092.045335239787, 9186.402883812565, 9192.540372981357, 9246.075392460767, 9269.258459323239, 9006.68476603319, 9041.502717350542, 9112.544372781367, 9116.316276279273, 9137.0, 9114.726558203265, 9123.406978546373, 9171.908280917205, 9174.954125229364, 9206.895172579267, 9071.092890710943, 9116.270698344117, 9123.543822808899, 9127.95436022819, 9140.862887056699, 9062.7281181564, 9186.770330741718, 9208.3093767967, 9208.90791092094, 9248.0, 42078.78960605208, 42273.36589951153, 42465.57534424678, 42592.361114583306, 42605.36091958623, 3845.7115716321387, 3888.2612303662495, 4181.97909010453, 4371.868843934687, 4387.232234359007, 31720.0, 31843.84078079618, 31947.680523194704, 31968.520472192937, 33147.6685233147, 3810.637989391031, 3876.123876123876, 3933.8033098344968, 3946.072672921861, 4059.3707975263587, 288642.0, 290243.0, 290542.0, 291317.0, 293491.0, 46444.0, 46929.0, 46980.0, 47039.29441058387, 47059.76470117696, 43689.56310436918, 43955.0, 44100.77949610232, 44110.0, 44192.77903610461, 16729.16354182286, 16890.662186756443, 16950.49148525546, 16951.660966780597, 16982.320707171573, 11699.707507312385, 11785.764284714258, 11793.351365674971, 11827.467763950643, 11864.050875930077, 15581.922090389475, 15664.765028524582, 15704.607384815243, 15704.900656954133, 15759.054456732632, 6273.153124328249, 6389.233292004897, 6448.419642232222, 6462.741490340428, 6527.379898909596, 1037.1650821088945, 1088.2327958789035, 1097.4457898761075, 1107.379867274329, 1116.0569318925495, 29960.85019574888, 30236.24409389739, 30252.54621180684, 30393.544096838566, 30491.390172196432, 1072.7371793910386, 1111.1166622535104, 1128.3624752015085, 1133.3596517967321, 1159.1596092832629, 14882.0, 14973.475928342456, 15146.621334466507, 15549.766753498707, 15550.300236489385, 696704.0, 713982.0, 738935.0, 740574.0, 741421.0, 60623.69688151531, 60843.69578152081, 61344.38655613476, 61535.692321539, 61627.0, 1409.7814838700017, 1422.1751384197141, 1465.4138344662008, 1536.5928029072081, 1537.4234662001525, 31157.221069473446, 31456.0, 31706.841465793445, 31787.364252715277, 32116.0, 49389.25916111189, 49494.75252623714, 49860.50139498703, 49909.25136123034, 49948.75025624849, 305065.0, 307003.0, 308507.0, 309171.0, 309610.0, 34492.48261276033, 35092.64907350894, 35179.64820351764, 35189.29621407506, 35584.46623300601, 46365.53634463612, 46444.53555464402, 47040.52959470498, 47500.7624961873, 47861.803454913905, 37187.0, 38397.0, 38597.80701096477, 39070.0, 40124.1975160501, 39006.219875602896, 39396.80301598473, 39549.60450395459, 39726.0, 40001.0, 39243.60756392399, 39350.60649393469, 39573.0, 39739.80130099331, 39867.40198897077, 33335.66664333326, 33787.83106084552, 34647.0, 34648.480272796434, 34733.30533389268, 26736.331591710365, 27535.173944781687, 28652.42695146127, 29270.560941585467, 29728.405431891675], "unit": "ms", "name": "ext.html", "value": 19654.18291737315}, {"lowerIsBetter": false, "replicates": [388.39022734307133, 396.4509154820573, 398.0, 398.058591431265, 402.1675132475775, 15889.682206355896, 17022.574435639086, 17181.828181718178, 18819.059047047645, 18905.810941890595, 11946.104042196848, 12314.692132696664, 12571.182873113241, 12604.0546958978, 12608.936955315234, 5267.499587539178, 5344.946550534503, 5367.704776237305, 5388.084025715618, 5392.757325920343, 5492.725363731817, 5632.718364081779, 5654.151877218409, 5674.063779476382, 5706.629069110515, 5598.664080155183, 5608.6073974821775, 5708.77164913403, 6299.622022678631, 6302.7163777629885, 6244.812655620339, 6291.968540157292, 6306.0, 6319.842003949938, 6327.240731112296, 5191.221316802472, 5321.201819727034, 5328.387235467932, 5344.465553444625, 5677.489025987639, 12962.092653514257, 13140.86859131406, 13166.473341066347, 13447.0, 13497.662558436019, 2293.7247530296304, 2320.454693147109, 2321.1643808229023, 2388.3909603051284, 2445.7921076708503, 10317.174626029975, 11286.0, 11764.058875290042, 13420.731585368336, 13710.588682339545, 1914.731937528747, 1968.3602829080462, 2004.859659823813, 2010.7587089549202, 2014.768301645315, 63140.68429657822, 63454.682726586536, 63802.68098659477, 64606.0, 66374.0, 10762.40806755636, 10936.179786516042, 10936.671899843017, 10956.726081848017, 10972.835407468734, 14667.266636668124, 14777.261136943325, 14902.478413255702, 14908.403663853542, 14970.70058598822, 8003.0, 8404.915950840536, 8461.576921153917, 8469.915300846913, 8546.230839224376, 8345.66617335312, 8376.958115209507, 8391.874121888177, 8418.789530261793, 8446.450980686235, 4620.861374158713, 4806.134895718735, 4868.78090485929, 4941.48114447985, 4947.060058588857, 1976.239147928058, 2013.6742062917353, 2043.6423625865414, 2052.374025922078, 2103.737032870891, 936.3632729743839, 978.5449765858909, 978.9021097890154, 990.7225976726528, 1027.0294571629738, 16706.58233544171, 16736.16319184036, 16906.661866762595, 17348.13404379409, 17357.04536250493, 972.5817898303798, 984.6209209454412, 1005.8131404942093, 1046.4296958157822, 1078.8489611454402, 9677.70966870995, 9993.850092248622, 10416.166706663449, 10690.144788416908, 10762.192835537366, 469602.0, 474301.0, 597269.0, 610498.0, 622660.0, 75903.62048189723, 84175.57912210522, 88443.55778221067, 89441.55279223692, 89654.0, 490.364977354327, 500.6445423749179, 502.14635120295645, 503.2928735127225, 504.46022755651836, 10430.37417754937, 10479.68560943173, 10635.521401537104, 10763.461826908466, 10794.136469082612, 36551.817240913624, 36744.81627591845, 37971.81014094912, 38367.04082397851, 39488.40767388434, 47044.76477617727, 49492.25761613651, 49660.751696241285, 49767.253491196934, 49903.251451228985, 9678.564464598969, 9818.558164882455, 10039.4478303694, 10400.323978941344, 10504.317219380715, 10999.23005389615, 11248.718782030515, 11275.267107637977, 12268.32524211177, 12402.379881006094, 10684.786304273715, 10929.39888306119, 11102.389368584805, 11165.274257173258, 11217.326960382403, 10834.404107773833, 10868.836967445337, 11010.229283950046, 11039.282446640942, 11054.613088541862, 11360.715982100182, 11454.370009649216, 11663.5917742882, 11666.70833229142, 11719.707007324885, 15048.849511504744, 15495.14776687293, 15638.218089095728, 16121.838781612034, 16587.91706041462, 15935.68128637444, 16067.27697253603, 16080.195990200677, 16182.271797768894, 16222.756658650365], "unit": "ms", "name": "jquery.html", "value": 8791.579368714629}, {"lowerIsBetter": false, "replicates": [1545.5131633535436, 1560.110736879978, 1797.1104303369818, 1856.071964017991, 1881.8964956927373, 8257.463264887778, 8362.91637083629, 8491.78770530737, 8508.787280317994, 8621.39650224483, 8601.397902146853, 8629.87055194171, 8666.783330416743, 8669.349798765086, 8695.86956195656, 2359.6460530920326, 2410.4214988402746, 2410.758924107593, 2413.6379543068592, 2415.420299128214, 2427.393151712072, 2442.24290469954, 2475.554400207971, 2476.6408870713735, 2481.3424442522746, 2286.302677683306, 2288.8512246703995, 2315.9536809263805, 2400.2079313826484, 2428.368624157723, 2336.1706594159, 2346.143657564985, 2356.4933539289136, 2364.84628499147, 2367.7750613691674, 2418.093215044358, 2448.926532204037, 2451.852888826676, 2452.6688896998853, 2453.7178224504232, 8171.305439037689, 8239.340852731768, 8241.8351632967, 8244.134365891616, 8279.089300177036, 4792.0, 4840.370751802243, 4846.273059041172, 4857.514248575149, 4877.463479017305, 3095.164305637488, 3109.67348428414, 3150.2754366495606, 3155.4162479941056, 3179.8569064391927, 946.129560804062, 956.9186619137312, 980.4901451245383, 1008.0373243552464, 1009.3590569988037, 10989.61536346224, 11070.833937490863, 11075.72310692231, 11099.778004439946, 11163.776724465546, 4358.891027724332, 4367.323064924942, 4412.757298348557, 4423.557644235615, 4465.151621191963, 9575.138237558514, 9575.186109180797, 9639.614415423444, 9642.614295428244, 9682.225421966226, 4890.364252647204, 4917.336159618406, 4926.4088309403105, 4939.2838038484215, 4939.753012349368, 4452.910941781146, 4455.4876189238, 4472.038511719996, 4489.685721999429, 4491.550844915482, 3820.0, 3869.3228684980018, 3880.359740642819, 3895.1235971906094, 3903.2974064668633, 1098.5166526728374, 1208.4863932828512, 1229.8524177098805, 1236.2397125767588, 1248.1387842388722, 1066.0938202527943, 1202.2546021466746, 1214.5081242096965, 1220.9206401584047, 1318.7428451451874, 7695.268949449794, 7806.882896756553, 7836.490628109154, 8095.66421540451, 8105.797355066053, 1246.5761641041909, 1250.0811903251104, 1250.8186312984567, 1261.0, 1263.810428435742, 6100.938990610126, 6104.816855494342, 6135.386461353918, 6158.445739883432, 6201.286852011986, 10136.949315253376, 10182.694519164437, 10314.226433017553, 10315.484225788681, 10345.27583069193, 9616.75958101053, 10100.343477674074, 10135.493225338703, 10204.489775511194, 10264.58941642326, 7854.8821767673535, 7879.2120787921895, 7997.760067197877, 8016.0, 8042.195780421911, 7729.497582657109, 7886.369090472863, 7967.880481792894, 7995.720149794729, 8014.158513356247, 8929.0, 8994.100589940954, 9102.59038343263, 9121.498317592595, 9165.450072995642, 9096.954515227382, 9306.022867598804, 9327.300452465957, 9508.477033763209, 9517.333786634868, 7577.355924746238, 7611.657475413509, 7685.807854803675, 7687.11598166218, 7694.846103078019, 8163.79590510242, 8291.253787159185, 8325.0, 8349.123342048997, 8356.582170891552, 7721.806954826175, 7740.8451830964195, 7803.258690424401, 7846.489978151402, 7891.289783919475, 6865.313468653095, 7244.855102898018, 7594.924050759421, 7687.0, 7709.0749110107145, 7592.164861865301, 7598.12621548529, 7606.581638009962, 7617.961910190414, 7644.426668000034, 6944.0, 7004.789856304319, 7036.577805331696, 7047.436205103477, 7086.1850887146575, 6824.658767061528, 6847.07564478789, 6880.621565813728, 6887.070245516791, 6889.724411023503], "unit": "ms", "name": "mootools.html", "value": 4796.536835254181}, {"lowerIsBetter": false, "replicates": [360.73666223656744, 362.41650941983403, 368.6958259435966, 371.32233673545784, 371.61909043230696, 6246.375362463751, 6300.495960323175, 6344.746210151594, 6396.136521569587, 6450.61296322221, 6189.823933452641, 6291.622502649844, 6363.459105975986, 6386.425221730044, 6389.744410223586, 4856.39295088114, 4895.5838753705975, 4900.436449808264, 4911.238757992499, 4914.680545764531, 4915.090708218991, 4919.975400123012, 4925.088858561177, 4929.309896614477, 4929.644347804347, 4714.5521175488275, 4855.854324370274, 4883.096627123976, 4892.584130348924, 4908.533689299511, 4860.975695121537, 4871.707697538123, 4896.363472748538, 4897.314375987365, 4912.4350699669285, 4249.936250956238, 4250.53244143144, 4252.55348188442, 4254.212970600449, 4259.31850903857, 6003.519718422515, 6118.653896142841, 6132.877342453171, 6138.508919286491, 6139.0, 5702.344230413472, 5702.521461908233, 5703.686297253649, 5708.200851880699, 5715.828525144252, 6794.116764820591, 6797.354251346114, 6802.65986700668, 6803.149606299213, 6816.7614133505085, 4711.952880471185, 4727.361806156194, 4728.38530990969, 4736.905261894777, 4747.83382581608, 6946.409555187815, 6982.1970473395195, 7075.823104422379, 7084.964575177142, 7092.9645351772915, 4864.805407783649, 4867.878303042452, 4869.610431165498, 4871.756412179448, 4880.536349046835, 4922.58158056562, 4926.926096108489, 4946.307516947631, 4947.678400904002, 4950.009998000414, 5618.719064046863, 5673.120666296731, 5707.3721890592005, 5722.313322401338, 5727.6849773262875, 6737.831554211086, 6784.287649796799, 6809.727610895508, 6873.243943166248, 6886.552374095668, 1694.2883988724766, 1735.2885317020214, 1739.0956702514875, 1741.1207340293072, 1746.580820603046, 1122.1920217443428, 1126.2510430563748, 1136.5056200552622, 1145.1583086431467, 1148.724306166514, 6525.64108974011, 6555.508336874754, 6574.211094668574, 6576.243731970789, 6672.499562532829, 7043.401310888529, 7047.788566343018, 7048.083749112582, 7060.71757129709, 7084.220735719066, 6541.2150541934325, 6563.409293163638, 6628.701708423133, 6664.86670266592, 6689.13041304637, 3806.2768074066394, 3834.8878825140955, 3835.5972622874756, 3845.750026248285, 3854.0557563397147, 7214.350708436266, 7238.131424229126, 7244.601546914865, 7245.311695388929, 7248.927510724825, 6988.19635741886, 7212.675429605575, 7218.927810721931, 7226.674799634029, 7242.275772422716, 7280.344768970818, 7368.263173682696, 7389.630518474055, 7402.333789959037, 7412.96293518529, 7179.0, 7196.136463624399, 7211.531250468703, 7221.819454513679, 7238.746643867439, 6983.0, 7088.149422069385, 7093.609851458219, 7112.466565007541, 7121.4302855770375, 7350.52221605594, 7373.820188769771, 7375.151857536452, 7379.0, 7396.852062958603, 4838.201696720002, 4902.431222008923, 4909.484504127158, 4912.778924948458, 4927.852164435073, 7012.439004879496, 7058.11773528309, 7091.858162836817, 7195.352418282379, 7203.531770434905, 6916.515843890879, 6964.582125072512, 6968.0, 6976.372126508639, 7008.983697363956, 6907.7236910525025, 6955.721771129098, 6972.895406569007, 6978.476614254053, 6983.127109111361, 6639.904415771343, 6828.146481689789, 6862.867626841516, 6866.725330986705, 6867.690953906987, 6996.335348141918, 7000.19497757744, 7005.964970175117, 7006.0, 7014.088168538057, 6656.667166641745, 6833.3166683331265, 6838.794836154923, 6839.794806155824, 6850.623215723183], "unit": "ms", "name": "prototype.html", "value": 5169.88686527935}, {"lowerIsBetter": false, "replicates": [799.5043073294559, 886.609891647675, 935.5369092299312, 942.3591957468918, 958.2765012415625, 12582.496700131995, 12744.299063551502, 12823.807642885364, 12877.291748953803, 12881.935590322058, 12519.186252893556, 12695.047871409635, 12715.936420317885, 12722.745545089092, 12729.618111456648, 903.4172958441801, 907.2968449451662, 908.1780988205685, 909.1499448016126, 909.8089401225717, 890.6259371064168, 903.2051794420934, 904.6336233825311, 905.302916754099, 906.4697152165958, 938.2869019545161, 942.6842007927319, 942.9575669094908, 943.580106852451, 945.475261230017, 919.2921450483124, 926.8470702334107, 929.4237572704966, 930.4138392812553, 930.860370944357, 698.1238545625258, 700.5691499727682, 701.8736627407064, 702.9402500787439, 703.6868593475905, 12922.41849116792, 13016.414261358166, 13042.0, 13072.869271307356, 13088.0, 11510.251833630871, 11684.065274777997, 12121.757564848742, 12238.755224895542, 12285.447154878051, 10010.549525271308, 10222.875483696787, 10433.21750868688, 10444.26890117692, 10719.517621707042, 3805.9619403805887, 3841.615838416136, 3860.845566177378, 3870.2453021660785, 3884.2231553689376, 50692.0, 50976.490235097546, 51016.99999999963, 51418.99999999963, 51634.74182629063, 9239.72280831576, 9702.417854928586, 9895.65365212214, 10029.0, 10052.899471005196, 18158.45524634263, 18791.06044697787, 18895.81104188968, 18899.716504252447, 19028.71456928147, 6705.597664140168, 7104.680289386886, 7187.137543494814, 7314.195438501761, 7629.351505122016, 3823.483829682957, 4120.567340429272, 4180.24755544005, 4243.172581346607, 4285.6785741068925, 3108.8134711917355, 3122.09459256813, 3135.890243841455, 3140.591723076031, 3143.387039527316, 567.1917517537493, 572.8023831778113, 573.8909607174623, 574.8476653686777, 586.2291087220377, 540.6053580885897, 614.7264467312093, 623.5011990407655, 646.4085361893815, 651.1242379000237, 7813.374930005586, 8368.41421100517, 8461.153884611489, 8521.403501754941, 8796.252318552995, 539.3581637850945, 605.4006533531859, 656.671664167916, 662.5461558832216, 673.3031312591543, 3729.2355067211156, 3838.3091043612417, 3857.0, 3899.8440062397185, 3933.370660694275, 61798.69100654558, 64093.35906640967, 64830.0275495868, 64903.0, 65050.67474662596, 48967.51032489629, 49327.0, 50376.496235037914, 50468.24297635538, 50518.0, 49290.014199715806, 49512.75243623759, 49801.50198498041, 50706.74646626743, 50794.49205507972, 7732.420068494998, 8135.389845761473, 8612.440191387539, 8616.913830861611, 8622.223999840044, 35034.82482587673, 35532.467012995345, 35695.46456803202, 36055.63944360523, 36284.0, 45260.54739452563, 46998.53001469941, 50555.24167137422, 50852.745736271085, 51082.23376649279, 10294.3823370598, 10450.059494645518, 10460.110890574386, 10630.787384252426, 10716.946415267874, 11310.321380717183, 11402.429878506207, 11493.195476316578, 11641.708957275798, 11710.473028713557, 10404.895951040393, 10527.631532896312, 10541.947290263499, 10601.310914790514, 10693.0, 10068.69793906184, 10424.166066714797, 10873.945630271797, 10920.399378033966, 11105.555777768799, 10521.210909181995, 10528.210384221062, 10531.947340263556, 10591.046805787517, 10754.73113172177, 9170.770730731785, 9340.206082483064, 9635.0, 9723.076307750753, 9924.15644670211, 8698.0, 8964.775880602776, 8988.955055224682, 9004.774880628036, 9104.453732776055], "unit": "ms", "name": "yui.html", "value": 6358.878307343426}], "name": "dromaeo_css", "value": 7319.240993477991}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 112.0, 112.0, 111.0, 122.0, 120.0, 111.0, 112.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 112.8}, {"lowerIsBetter": true, "replicates": [150.0, 133.0, 153.0, 152.0, 123.0, 153.0, 157.0, 125.0, 171.0, 125.0], "unit": "ms", "name": "audio-beat-detection", "value": 144.2}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 162.0, 164.0, 163.0, 166.0, 161.0, 163.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 162.8}, {"lowerIsBetter": true, "replicates": [81.0, 73.0, 72.0, 160.0, 80.0, 71.0, 72.0, 74.0, 159.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 91.4}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 148.0, 93.0, 93.0, 93.0, 137.0, 93.0, 93.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 106.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 112.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [151.0, 147.0, 147.0, 146.0, 147.0, 146.0, 148.0, 147.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [58.0, 62.0, 61.0, 60.0, 60.0, 63.0, 60.0, 62.0, 58.0, 61.0], "unit": "ms", "name": "json-parse-financial", "value": 60.5}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 64.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 64.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 82.0, 82.0, 90.0, 82.0, 82.0, 81.0, 81.0, 89.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [112.0, 111.0, 121.0, 120.0, 111.0, 121.0, 128.0, 128.0, 115.0, 115.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.2}, {"lowerIsBetter": true, "replicates": [143.0, 147.0, 144.0, 156.0, 147.0, 144.0, 142.0, 143.0, 145.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 66.0, 65.0, 66.0, 65.0, 66.0, 64.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.8}], "name": "kraken", "value": 1508.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.19577862722286], "unit": "score", "name": "Richards", "value": 212.41213400000004}, {"lowerIsBetter": false, "replicates": [173.58097552508247], "unit": "score", "name": "DeltaBlue", "value": 380.90579799999983}, {"lowerIsBetter": false, "replicates": [282.56569652444193], "unit": "score", "name": "Encrypt", "value": 942.0145590000004}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [925.925925925926], "unit": "score", "name": "RayTrace", "value": 799.1881199999998}, {"lowerIsBetter": false, "replicates": [545.5537370430987], "unit": "score", "name": "Earley", "value": 1221.626679}, {"lowerIsBetter": false, "replicates": [11131.868131868132], "unit": "score", "name": "Boyer", "value": 59.869825271470894}, {"lowerIsBetter": false, "replicates": [24261.904761904763], "unit": "score", "name": "RegExp", "value": 37.547958783120734}, {"lowerIsBetter": false, "replicates": [529.1005291005291], "unit": "score", "name": "Splay", "value": 154.01798999999997}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 23048.59304306609}]} 08:53:52 INFO - RETURN: dromaeo_css: 7319.24 08:53:52 INFO - RETURN: kraken: 1508.70 08:53:52 INFO - RETURN: v8_7: 23048.59 08:53:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23048.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1508.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7319.24"}}} 08:53:52 INFO - Return code: 0 08:53:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:53:52 INFO - # TBPL SUCCESS # 08:53:52 INFO - Running post-action listener: _resource_record_post_action 08:53:52 INFO - Running post-run listener: _resource_record_post_run 08:53:53 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 4096; Write bytes: 512147456; Read time: 16; Write time: 731776 08:53:53 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 236642304; Read time: 0; Write time: 483596 08:53:53 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274640896; Read time: 16; Write time: 248124 08:53:53 INFO - Running post-run listener: _upload_blobber_files 08:53:53 INFO - Blob upload gear active. 08:53:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:53:53 INFO - Copying logs to upload dir... 08:53:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1274.300601 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-30 08:53:52.738839) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-30 08:53:52.745922) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009925 build_url: 'https://queue.taskcluster.net/v1/task/WLvV-kAUSHqp2T2pFz9YuA/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-30 08:53:52.773039) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:53:52.773400) ========= 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=0ae9de487587ba4b94dd3100000001b5-1451493043.372311-34407869 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 08:53:52.828707) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 08:53:52.829102) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 08:53:52.829469) ========= ========= Total master_lag: 0.20 =========