builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1453737881.05 results: success (0) buildid: 20160125053002 builduid: 3500ac2e22e94f578660573acbb402f6 revision: 671e1d2fe00379370df4f14f1fb7396f8eae2877 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:41.050766) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:41.051186) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:41.051472) ========= 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=aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006344 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:41.075021) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:41.075316) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:41.117529) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:41.117835) ========= 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=aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.23 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:41.354583) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:41.354859) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:41.355461) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:41.358540) ========= 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=aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 08:04:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.6M=0s 2016-01-25 08:04:41 (35.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127399 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:41.521775) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:41.522087) ========= 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=aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019494 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:41.576271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:41.576610) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 671e1d2fe00379370df4f14f1fb7396f8eae2877 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 671e1d2fe00379370df4f14f1fb7396f8eae2877 --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=aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 08:04:41,962 truncating revision to first 12 chars 2016-01-25 08:04:41,963 Setting DEBUG logging. 2016-01-25 08:04:41,963 attempt 1/10 2016-01-25 08:04:41,963 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/671e1d2fe003?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 08:04:42,344 unpacking tar archive at: b2g-inbound-671e1d2fe003/testing/mozharness/ program finished with exit code 0 elapsedTime=0.696284 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:42.288837) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:42.289187) ========= echo 671e1d2fe00379370df4f14f1fb7396f8eae2877 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'671e1d2fe00379370df4f14f1fb7396f8eae2877'] 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=aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 671e1d2fe00379370df4f14f1fb7396f8eae2877 program finished with exit code 0 elapsedTime=0.004605 script_repo_revision: '671e1d2fe00379370df4f14f1fb7396f8eae2877' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:42.340175) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:42.340493) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 08:04:42.350105) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-25 08:04:42.350585) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 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', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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=aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:04:42 INFO - MultiFileLogger online at 20160125 08:04:42 in /builds/slave/test-pgo 08:04:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 08:04:42 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 08:04:42 INFO - {'append_to_log': False, 08:04:42 INFO - 'base_work_dir': '/builds/slave/test-pgo', 08:04:42 INFO - 'blob_upload_branch': 'B2G-Inbound', 08:04:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 08:04:42 INFO - 'branch': 'B2G-Inbound', 08:04:42 INFO - 'buildbot_json_path': 'buildprops.json', 08:04:42 INFO - 'config_files': ('talos/linux_config.py',), 08:04:42 INFO - 'default_actions': ('clobber', 08:04:42 INFO - 'read-buildbot-config', 08:04:42 INFO - 'download-and-extract', 08:04:42 INFO - 'populate-webroot', 08:04:42 INFO - 'create-virtualenv', 08:04:42 INFO - 'install', 08:04:42 INFO - 'run-tests'), 08:04:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:04:42 INFO - 'download_minidump_stackwalk': True, 08:04:42 INFO - 'download_symbols': 'ondemand', 08:04:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:04:42 INFO - 'tooltool.py': '/tools/tooltool.py', 08:04:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:04:42 INFO - '/tools/misc-python/virtualenv.py')}, 08:04:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:04:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:04:42 INFO - 'installer_path': 'installer.exe', 08:04:42 INFO - 'log_level': 'info', 08:04:42 INFO - 'log_name': 'talos', 08:04:42 INFO - 'log_to_console': True, 08:04:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:04:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:04:42 INFO - 'opt_config_files': (), 08:04:42 INFO - 'pip_index': False, 08:04:42 INFO - 'sps_profile': False, 08:04:42 INFO - 'sps_profile_interval': 0, 08:04:42 INFO - 'suite': 'dromaeojs', 08:04:42 INFO - 'system_bits': '32', 08:04:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:04:42 INFO - 'title': 'talos-linux64-ix-037', 08:04:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:04:42 INFO - 'use_talos_json': True, 08:04:42 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 08:04:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:04:42 INFO - 'work_dir': 'build'} 08:04:42 INFO - ##### 08:04:42 INFO - ##### Running clobber step. 08:04:42 INFO - ##### 08:04:42 INFO - Running pre-action listener: _resource_record_pre_action 08:04:42 INFO - Running main action method: clobber 08:04:42 INFO - rmtree: /builds/slave/test-pgo/build 08:04:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 08:04:43 INFO - Running post-action listener: _resource_record_post_action 08:04:43 INFO - ##### 08:04:43 INFO - ##### Running read-buildbot-config step. 08:04:43 INFO - ##### 08:04:43 INFO - Running pre-action listener: _resource_record_pre_action 08:04:43 INFO - Running main action method: read_buildbot_config 08:04:43 INFO - Using buildbot properties: 08:04:43 INFO - { 08:04:43 INFO - "project": "", 08:04:43 INFO - "product": "firefox", 08:04:43 INFO - "script_repo_revision": "production", 08:04:43 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 08:04:43 INFO - "repository": "", 08:04:43 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 08:04:43 INFO - "buildid": "20160125053002", 08:04:43 INFO - "pgo_build": "True", 08:04:43 INFO - "basedir": "/builds/slave/test-pgo", 08:04:43 INFO - "buildnumber": 230, 08:04:43 INFO - "slavename": "talos-linux64-ix-037", 08:04:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:04:43 INFO - "platform": "ubuntu64_hw", 08:04:43 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 08:04:43 INFO - "branch": "b2g-inbound", 08:04:43 INFO - "repo_path": "integration/b2g-inbound", 08:04:43 INFO - "revision": "671e1d2fe00379370df4f14f1fb7396f8eae2877", 08:04:43 INFO - "stage_platform": "linux64-pgo", 08:04:43 INFO - "builduid": "3500ac2e22e94f578660573acbb402f6", 08:04:43 INFO - "slavebuilddir": "test" 08:04:43 INFO - } 08:04:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:04:43 INFO - Running post-action listener: _resource_record_post_action 08:04:43 INFO - ##### 08:04:43 INFO - ##### Running download-and-extract step. 08:04:43 INFO - ##### 08:04:43 INFO - Running pre-action listener: _resource_record_pre_action 08:04:43 INFO - Running main action method: download_and_extract 08:04:43 INFO - mkdir: /builds/slave/test-pgo/build/tests 08:04:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:43 INFO - https://queue.taskcluster.net/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:04:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/test_packages.json 08:04:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/test_packages.json 08:04:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 08:04:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 08:04:44 INFO - Downloaded 1448 bytes. 08:04:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 08:04:44 INFO - Using the following test package requirements: 08:04:44 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:44 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:04:44 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:04:44 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:44 INFO - u'jsshell-linux-x86_64.zip'], 08:04:44 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:04:44 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:44 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:04:44 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:04:44 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:04:44 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:04:44 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:04:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:04:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:04: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:04:44 INFO - https://queue.taskcluster.net/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:04:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:04:46 INFO - Downloaded 22494237 bytes. 08:04:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:04:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:04:47 INFO - Return code: 0 08:04:47 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:04:47 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:04:47 INFO - https://queue.taskcluster.net/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:04:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:04:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:04:48 INFO - Downloaded 22494237 bytes. 08:04:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:04:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 08:04:49 INFO - Return code: 0 08:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:49 INFO - https://queue.taskcluster.net/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:04:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:04:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:04:52 INFO - Downloaded 10706572 bytes. 08:04:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 08:04:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 08:04:52 INFO - Return code: 0 08:04: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:04:52 INFO - https://queue.taskcluster.net/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:04:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:04:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:04:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:04:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:04:54 INFO - Downloaded 55994172 bytes. 08:04:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:04:54 INFO - mkdir: /builds/slave/test-pgo/properties 08:04:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 08:04:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 08:04:54 INFO - Contents: 08:04:54 INFO - build_url:https://queue.taskcluster.net/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:04:54 INFO - Running post-action listener: _resource_record_post_action 08:04:54 INFO - Running post-action listener: set_extra_try_arguments 08:04:54 INFO - ##### 08:04:54 INFO - ##### Running populate-webroot step. 08:04:54 INFO - ##### 08:04:54 INFO - Running pre-action listener: _resource_record_pre_action 08:04:54 INFO - Running main action method: populate_webroot 08:04:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:04:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:04:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:04:54 INFO - '--tppagecycles', 08:04:54 INFO - '7'], 08:04:54 INFO - 'tests': ['tsvgm']}}, 08:04:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:04:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:04:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:04:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:04:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:04:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:04:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:54 INFO - 'talos_options': ['--e10s'], 08:04:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:04:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:54 INFO - 'tests': ['damp', 'tps']}, 08:04:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:54 INFO - 'talos_options': ['--e10s'], 08:04:54 INFO - 'tests': ['damp', 'tps']}, 08:04:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:04:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:04:54 INFO - 'other': {'tests': ['a11yr', 08:04:54 INFO - 'ts_paint', 08:04:54 INFO - 'tpaint', 08:04:54 INFO - 'sessionrestore', 08:04:54 INFO - 'sessionrestore_no_auto_restore']}, 08:04:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:04:54 INFO - 'tests': ['a11yr', 08:04:54 INFO - 'ts_paint', 08:04:54 INFO - 'tpaint', 08:04:54 INFO - 'sessionrestore', 08:04:54 INFO - 'sessionrestore_no_auto_restore']}, 08:04:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:04:54 INFO - 'tests': ['a11yr', 08:04:54 INFO - 'ts_paint', 08:04:54 INFO - 'tpaint', 08:04:54 INFO - 'sessionrestore', 08:04:54 INFO - 'sessionrestore_no_auto_restore']}, 08:04:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:04:54 INFO - 'tests': ['a11yr', 08:04:54 INFO - 'ts_paint', 08:04:54 INFO - 'tpaint', 08:04:54 INFO - 'sessionrestore', 08:04:54 INFO - 'sessionrestore_no_auto_restore']}, 08:04:54 INFO - 'other_l64': {'tests': ['a11yr', 08:04:54 INFO - 'ts_paint', 08:04:54 INFO - 'tpaint', 08:04:54 INFO - 'sessionrestore', 08:04:54 INFO - 'sessionrestore_no_auto_restore']}, 08:04:54 INFO - 'other_nol64': {'tests': ['a11yr', 08:04:54 INFO - 'ts_paint', 08:04:54 INFO - 'tpaint', 08:04:54 INFO - 'sessionrestore', 08:04:54 INFO - 'sessionrestore_no_auto_restore']}, 08:04:54 INFO - 'svgr': {'tests': ['tsvgx', 08:04:54 INFO - 'tsvgr_opacity', 08:04:54 INFO - 'tart', 08:04:54 INFO - 'tscrollx', 08:04:54 INFO - 'cart']}, 08:04:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:04:54 INFO - 'tests': ['tsvgx', 08:04:54 INFO - 'tsvgr_opacity', 08:04:54 INFO - 'tart', 08:04:54 INFO - 'tscrollx', 08:04:54 INFO - 'cart']}, 08:04:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:54 INFO - 'tests': ['tp5o']}, 08:04:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:54 INFO - 'talos_options': ['--e10s'], 08:04:54 INFO - 'tests': ['tp5o']}, 08:04:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:54 INFO - 'talos_options': ['--xperf_path', 08:04:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:54 INFO - 'tests': ['tp5n']}, 08:04:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:04:54 INFO - 'talos_options': ['--e10s', 08:04:54 INFO - '--xperf_path', 08:04:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:04:54 INFO - 'tests': ['tp5n']}}, 08:04:54 INFO - 'talos.zip': {'path': '', 08:04:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:04:54 INFO - Running post-action listener: _resource_record_post_action 08:04:54 INFO - ##### 08:04:54 INFO - ##### Running create-virtualenv step. 08:04:54 INFO - ##### 08:04:54 INFO - Running pre-action listener: _resource_record_pre_action 08:04:54 INFO - Running main action method: create_virtualenv 08:04:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 08:04:54 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:04:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 08:04:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:04:54 INFO - Using real prefix '/usr' 08:04:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 08:04:55 INFO - Installing distribute.............................................................................................................................................................................................done. 08:04:57 INFO - Installing pip.................done. 08:04:57 INFO - Return code: 0 08:04:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 08:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73bb67ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852840>, '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 0x17bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', '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:04:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 08:04:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:04:57 INFO - Using env: {'DISPLAY': ':0', 08:04:57 INFO - 'HOME': '/home/cltbld', 08:04:57 INFO - 'LANG': 'en_US.UTF-8', 08:04:57 INFO - 'LANGUAGE': 'en_US:en', 08:04:57 INFO - 'LOGNAME': 'cltbld', 08:04:57 INFO - 'MAIL': '/var/mail/cltbld', 08:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:57 INFO - 'MOZ_NO_REMOTE': '1', 08:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:57 INFO - 'NO_EM_RESTART': '1', 08:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:57 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:57 INFO - 'SHELL': '/bin/bash', 08:04:57 INFO - 'SHLVL': '1', 08:04:57 INFO - 'TERM': 'linux', 08:04:57 INFO - 'TMOUT': '86400', 08:04:57 INFO - 'USER': 'cltbld', 08:04:57 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', 08:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:57 INFO - '_': '/tools/buildbot/bin/python'} 08:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:57 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:04:57 INFO - Cleaning up... 08:04:57 INFO - Return code: 0 08:04:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 08:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:04:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73bb67ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852840>, '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 0x17bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', '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:04:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 08:04:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:04:57 INFO - Using env: {'DISPLAY': ':0', 08:04:57 INFO - 'HOME': '/home/cltbld', 08:04:57 INFO - 'LANG': 'en_US.UTF-8', 08:04:57 INFO - 'LANGUAGE': 'en_US:en', 08:04:57 INFO - 'LOGNAME': 'cltbld', 08:04:57 INFO - 'MAIL': '/var/mail/cltbld', 08:04:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:57 INFO - 'MOZ_NO_REMOTE': '1', 08:04:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:04:57 INFO - 'NO_EM_RESTART': '1', 08:04:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:04:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:04:57 INFO - 'PWD': '/builds/slave/test-pgo', 08:04:57 INFO - 'SHELL': '/bin/bash', 08:04:57 INFO - 'SHLVL': '1', 08:04:57 INFO - 'TERM': 'linux', 08:04:57 INFO - 'TMOUT': '86400', 08:04:57 INFO - 'USER': 'cltbld', 08:04:57 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', 08:04:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:57 INFO - '_': '/tools/buildbot/bin/python'} 08:04:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:57 INFO - Downloading/unpacking psutil>=0.7.1 08:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 08:04:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:59 INFO - Installing collected packages: psutil 08:04:59 INFO - Running setup.py install for psutil 08:04:59 INFO - building 'psutil._psutil_linux' extension 08:04:59 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:04:59 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:04:59 INFO - building 'psutil._psutil_posix' extension 08:04:59 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:04:59 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:04:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:59 INFO - Successfully installed psutil 08:04:59 INFO - Cleaning up... 08:05:00 INFO - Return code: 0 08:05:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 08:05: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:05:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05: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:05:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73bb67ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852840>, '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 0x17bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', '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:05:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 08:05:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:05:00 INFO - Using env: {'DISPLAY': ':0', 08:05:00 INFO - 'HOME': '/home/cltbld', 08:05:00 INFO - 'LANG': 'en_US.UTF-8', 08:05:00 INFO - 'LANGUAGE': 'en_US:en', 08:05:00 INFO - 'LOGNAME': 'cltbld', 08:05:00 INFO - 'MAIL': '/var/mail/cltbld', 08:05:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:00 INFO - 'MOZ_NO_REMOTE': '1', 08:05:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:00 INFO - 'NO_EM_RESTART': '1', 08:05:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:05:00 INFO - 'PWD': '/builds/slave/test-pgo', 08:05:00 INFO - 'SHELL': '/bin/bash', 08:05:00 INFO - 'SHLVL': '1', 08:05:00 INFO - 'TERM': 'linux', 08:05:00 INFO - 'TMOUT': '86400', 08:05:00 INFO - 'USER': 'cltbld', 08:05:00 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', 08:05:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:00 INFO - '_': '/tools/buildbot/bin/python'} 08:05:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:05:00 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:05:00 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:05:00 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:05:00 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:05:00 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:05:00 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:05:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:05:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:05:02 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:05:02 INFO - Installing collected packages: mozsystemmonitor 08:05:02 INFO - Running setup.py install for mozsystemmonitor 08:05:02 INFO - Successfully installed mozsystemmonitor 08:05:02 INFO - Cleaning up... 08:05:02 INFO - Return code: 0 08:05:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 08:05:02 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:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:02 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:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73bb67ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852840>, '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 0x17bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', '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:05:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 08:05:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:05:02 INFO - Using env: {'DISPLAY': ':0', 08:05:02 INFO - 'HOME': '/home/cltbld', 08:05:02 INFO - 'LANG': 'en_US.UTF-8', 08:05:02 INFO - 'LANGUAGE': 'en_US:en', 08:05:02 INFO - 'LOGNAME': 'cltbld', 08:05:02 INFO - 'MAIL': '/var/mail/cltbld', 08:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:02 INFO - 'MOZ_NO_REMOTE': '1', 08:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:02 INFO - 'NO_EM_RESTART': '1', 08:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:05:02 INFO - 'PWD': '/builds/slave/test-pgo', 08:05:02 INFO - 'SHELL': '/bin/bash', 08:05:02 INFO - 'SHLVL': '1', 08:05:02 INFO - 'TERM': 'linux', 08:05:02 INFO - 'TMOUT': '86400', 08:05:02 INFO - 'USER': 'cltbld', 08:05:02 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', 08:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:02 INFO - '_': '/tools/buildbot/bin/python'} 08:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:02 INFO - Downloading/unpacking blobuploader==1.2.4 08:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:04 INFO - Downloading blobuploader-1.2.4.tar.gz 08:05:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:05:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 08:05:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:05:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:05:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:05:04 INFO - Downloading docopt-0.6.1.tar.gz 08:05:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 08:05:04 INFO - Installing collected packages: blobuploader, requests, docopt 08:05:04 INFO - Running setup.py install for blobuploader 08:05:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:05:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 08:05:05 INFO - Running setup.py install for requests 08:05:05 INFO - Running setup.py install for docopt 08:05:05 INFO - Successfully installed blobuploader requests docopt 08:05:05 INFO - Cleaning up... 08:05:05 INFO - Return code: 0 08:05:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:05:05 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:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:05 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:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73bb67ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852840>, '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 0x17bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', '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:05:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:05:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:05 INFO - Using env: {'DISPLAY': ':0', 08:05:05 INFO - 'HOME': '/home/cltbld', 08:05:05 INFO - 'LANG': 'en_US.UTF-8', 08:05:05 INFO - 'LANGUAGE': 'en_US:en', 08:05:05 INFO - 'LOGNAME': 'cltbld', 08:05:05 INFO - 'MAIL': '/var/mail/cltbld', 08:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:05 INFO - 'MOZ_NO_REMOTE': '1', 08:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:05 INFO - 'NO_EM_RESTART': '1', 08:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:05:05 INFO - 'PWD': '/builds/slave/test-pgo', 08:05:05 INFO - 'SHELL': '/bin/bash', 08:05:05 INFO - 'SHLVL': '1', 08:05:05 INFO - 'TERM': 'linux', 08:05:05 INFO - 'TMOUT': '86400', 08:05:05 INFO - 'USER': 'cltbld', 08:05:05 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', 08:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:05 INFO - '_': '/tools/buildbot/bin/python'} 08:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:05:05 INFO - Running setup.py (path:/tmp/pip-mXDZ_J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:05:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:05:05 INFO - Running setup.py (path:/tmp/pip-NYpPiL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:05:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:05:05 INFO - Running setup.py (path:/tmp/pip-wWpHZz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:05:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:05:05 INFO - Running setup.py (path:/tmp/pip-FF_xjP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:05:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:05:06 INFO - Running setup.py (path:/tmp/pip-dndkC1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:05:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:05:06 INFO - Running setup.py (path:/tmp/pip-t2h4A0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:05:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:05:06 INFO - Running setup.py (path:/tmp/pip-9Hf_cf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:05:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:05:06 INFO - Running setup.py (path:/tmp/pip-KHdQZs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:05:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:05:06 INFO - Running setup.py (path:/tmp/pip-YtlqyX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:05:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:05:06 INFO - Running setup.py (path:/tmp/pip-14cTWo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:05:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:05:06 INFO - Running setup.py (path:/tmp/pip-5AsmbM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:05:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:05:06 INFO - Running setup.py (path:/tmp/pip-zs6Jm_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:05:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:05:06 INFO - Running setup.py (path:/tmp/pip-Vz3Iyu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:05:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:05:06 INFO - Running setup.py (path:/tmp/pip-sZb_ia-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:05:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:05:06 INFO - Running setup.py (path:/tmp/pip-IG62Cj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:05:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:05:06 INFO - Running setup.py (path:/tmp/pip-Jx5Ojr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:05:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:05:06 INFO - Running setup.py (path:/tmp/pip-Gin9oA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:05:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:05:06 INFO - Running setup.py install for manifestparser 08:05:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 08:05:07 INFO - Running setup.py install for mozcrash 08:05:07 INFO - Running setup.py install for mozdebug 08:05:07 INFO - Running setup.py install for mozdevice 08:05:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 08:05:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 08:05:07 INFO - Running setup.py install for mozfile 08:05:07 INFO - Running setup.py install for mozhttpd 08:05:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 08:05:07 INFO - Running setup.py install for mozinfo 08:05:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 08:05:07 INFO - Running setup.py install for mozInstall 08:05:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 08:05:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 08:05:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 08:05:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 08:05:07 INFO - Running setup.py install for mozleak 08:05:07 INFO - Running setup.py install for mozlog 08:05:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 08:05:07 INFO - Running setup.py install for moznetwork 08:05:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 08:05:08 INFO - Running setup.py install for mozprocess 08:05:08 INFO - Running setup.py install for mozprofile 08:05:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 08:05:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 08:05:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 08:05:08 INFO - Running setup.py install for mozrunner 08:05:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 08:05:08 INFO - Running setup.py install for mozscreenshot 08:05:08 INFO - Running setup.py install for moztest 08:05:08 INFO - Running setup.py install for mozversion 08:05:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 08:05:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:05:08 INFO - Cleaning up... 08:05:08 INFO - Return code: 0 08:05:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:05:08 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:05:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:08 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:05:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73bb67ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852840>, '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 0x17bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', '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:05:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 08:05:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:08 INFO - Using env: {'DISPLAY': ':0', 08:05:08 INFO - 'HOME': '/home/cltbld', 08:05:08 INFO - 'LANG': 'en_US.UTF-8', 08:05:08 INFO - 'LANGUAGE': 'en_US:en', 08:05:08 INFO - 'LOGNAME': 'cltbld', 08:05:08 INFO - 'MAIL': '/var/mail/cltbld', 08:05:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:08 INFO - 'MOZ_NO_REMOTE': '1', 08:05:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:08 INFO - 'NO_EM_RESTART': '1', 08:05:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:05:08 INFO - 'PWD': '/builds/slave/test-pgo', 08:05:08 INFO - 'SHELL': '/bin/bash', 08:05:08 INFO - 'SHLVL': '1', 08:05:08 INFO - 'TERM': 'linux', 08:05:08 INFO - 'TMOUT': '86400', 08:05:08 INFO - 'USER': 'cltbld', 08:05:08 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', 08:05:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:08 INFO - '_': '/tools/buildbot/bin/python'} 08:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:05:08 INFO - Running setup.py (path:/tmp/pip-xaQgTo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 08:05:09 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:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:05:09 INFO - Running setup.py (path:/tmp/pip-xOBwEV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 08:05:09 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:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:05:09 INFO - Running setup.py (path:/tmp/pip-OawT47-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 08:05:09 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:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:05:09 INFO - Running setup.py (path:/tmp/pip-HCujx9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 08:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 08:05:09 INFO - Running setup.py (path:/tmp/pip-BbOMde-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 08:05:09 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:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:05:09 INFO - Running setup.py (path:/tmp/pip-6wW5Bv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 08:05:09 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:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:05:09 INFO - Running setup.py (path:/tmp/pip-Dc14Vt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 08:05:09 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:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:05:09 INFO - Running setup.py (path:/tmp/pip-Ay4BZg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 08:05:09 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:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 08:05:09 INFO - Running setup.py (path:/tmp/pip-Ua21mF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 08:05:09 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:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 08:05:09 INFO - Running setup.py (path:/tmp/pip-jGcYBZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 08:05:09 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:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:05:09 INFO - Running setup.py (path:/tmp/pip-ILHT6Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 08:05:09 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:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:05:09 INFO - Running setup.py (path:/tmp/pip-5f0q4G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 08:05:09 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:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:05:09 INFO - Running setup.py (path:/tmp/pip-HxZZEr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 08:05:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:05:09 INFO - Running setup.py (path:/tmp/pip-65xf_F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 08:05:09 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:05:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:05:09 INFO - Running setup.py (path:/tmp/pip-f1wQA9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 08:05:10 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:05:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 08:05:10 INFO - Running setup.py (path:/tmp/pip-0HyTqn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 08:05:10 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:05:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 08:05:10 INFO - Running setup.py (path:/tmp/pip-x1k0IF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 08:05:10 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:05:10 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:05:10 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:05:10 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:05:10 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:10 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 08:05:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 08:05:10 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:05:10 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:05:10 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:05:10 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:05:10 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:05:10 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:05:11 INFO - Downloading blessings-1.6.tar.gz 08:05:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 08:05:12 INFO - Installing collected packages: blessings 08:05:12 INFO - Running setup.py install for blessings 08:05:12 INFO - Successfully installed blessings 08:05:12 INFO - Cleaning up... 08:05:12 INFO - Return code: 0 08:05:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 08:05:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:05:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:05:12 INFO - Reading from file tmpfile_stdout 08:05:12 INFO - Current package versions: 08:05:12 INFO - argparse == 1.2.1 08:05:12 INFO - blessings == 1.6 08:05:12 INFO - blobuploader == 1.2.4 08:05:12 INFO - docopt == 0.6.1 08:05:12 INFO - manifestparser == 1.1 08:05:12 INFO - mozInstall == 1.12 08:05:12 INFO - mozcrash == 0.16 08:05:12 INFO - mozdebug == 0.1 08:05:12 INFO - mozdevice == 0.48 08:05:12 INFO - mozfile == 1.2 08:05:12 INFO - mozhttpd == 0.7 08:05:12 INFO - mozinfo == 0.9 08:05:12 INFO - mozleak == 0.1 08:05:12 INFO - mozlog == 3.1 08:05:12 INFO - moznetwork == 0.27 08:05:12 INFO - mozprocess == 0.22 08:05:12 INFO - mozprofile == 0.28 08:05:12 INFO - mozrunner == 6.11 08:05:12 INFO - mozscreenshot == 0.1 08:05:12 INFO - mozsystemmonitor == 0.0 08:05:12 INFO - moztest == 0.7 08:05:12 INFO - mozversion == 1.4 08:05:12 INFO - psutil == 3.1.1 08:05:12 INFO - requests == 1.2.3 08:05:12 INFO - wsgiref == 0.1.2 08:05:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 08:05:12 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:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:12 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:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73bb67ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852840>, '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 0x17bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', '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:05:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 08:05:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:05:12 INFO - Using env: {'DISPLAY': ':0', 08:05:12 INFO - 'HOME': '/home/cltbld', 08:05:12 INFO - 'LANG': 'en_US.UTF-8', 08:05:12 INFO - 'LANGUAGE': 'en_US:en', 08:05:12 INFO - 'LOGNAME': 'cltbld', 08:05:12 INFO - 'MAIL': '/var/mail/cltbld', 08:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:12 INFO - 'MOZ_NO_REMOTE': '1', 08:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:12 INFO - 'NO_EM_RESTART': '1', 08:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:05:12 INFO - 'PWD': '/builds/slave/test-pgo', 08:05:12 INFO - 'SHELL': '/bin/bash', 08:05:12 INFO - 'SHLVL': '1', 08:05:12 INFO - 'TERM': 'linux', 08:05:12 INFO - 'TMOUT': '86400', 08:05:12 INFO - 'USER': 'cltbld', 08:05:12 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', 08:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:12 INFO - '_': '/tools/buildbot/bin/python'} 08:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 08:05:12 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 2)) 08:05:12 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 3)) 08:05:12 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 4)) 08:05:12 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 5)) 08:05:12 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 6)) 08:05:12 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 7)) 08:05:12 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 8)) 08:05:12 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 9)) 08:05:12 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 08:05:12 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 4)) 08:05:12 INFO - Cleaning up... 08:05:12 INFO - Return code: 0 08:05:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 08:05:12 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:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:12 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:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73bb67ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852840>, '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 0x17bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', '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:05:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 08:05:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:05:12 INFO - Using env: {'DISPLAY': ':0', 08:05:12 INFO - 'HOME': '/home/cltbld', 08:05:12 INFO - 'LANG': 'en_US.UTF-8', 08:05:12 INFO - 'LANGUAGE': 'en_US:en', 08:05:12 INFO - 'LOGNAME': 'cltbld', 08:05:12 INFO - 'MAIL': '/var/mail/cltbld', 08:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:12 INFO - 'MOZ_NO_REMOTE': '1', 08:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:12 INFO - 'NO_EM_RESTART': '1', 08:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:05:12 INFO - 'PWD': '/builds/slave/test-pgo', 08:05:12 INFO - 'SHELL': '/bin/bash', 08:05:12 INFO - 'SHLVL': '1', 08:05:12 INFO - 'TERM': 'linux', 08:05:12 INFO - 'TMOUT': '86400', 08:05:12 INFO - 'USER': 'cltbld', 08:05:12 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', 08:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:12 INFO - '_': '/tools/buildbot/bin/python'} 08:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:12 INFO - Downloading/unpacking jsonschema 08:05:12 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:05:12 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:05:12 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:05:12 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:05:12 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:05:12 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:05:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:05:14 INFO - Downloading/unpacking functools32 (from jsonschema) 08:05:14 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:05:14 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:05:14 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:05:14 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:05:14 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:05:14 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:05:14 INFO - Downloading functools32-3.2.3-2.tar.gz 08:05:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 08:05:14 INFO - warning: no files found matching '*.txt' 08:05:14 INFO - no previously-included directories found matching 'build' 08:05:14 INFO - no previously-included directories found matching 'dist' 08:05:14 INFO - no previously-included directories found matching '.git*' 08:05:14 INFO - Installing collected packages: jsonschema, functools32 08:05:14 INFO - Running setup.py install for functools32 08:05:14 INFO - warning: no files found matching '*.txt' 08:05:14 INFO - no previously-included directories found matching 'build' 08:05:14 INFO - no previously-included directories found matching 'dist' 08:05:14 INFO - no previously-included directories found matching '.git*' 08:05:14 INFO - Successfully installed jsonschema functools32 08:05:14 INFO - Cleaning up... 08:05:15 INFO - Return code: 0 08:05:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 08:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:05:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:05:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:05:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f73bb67ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c1630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1852840>, '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 0x17bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', '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:05:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 08:05:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:05:15 INFO - Using env: {'DISPLAY': ':0', 08:05:15 INFO - 'HOME': '/home/cltbld', 08:05:15 INFO - 'LANG': 'en_US.UTF-8', 08:05:15 INFO - 'LANGUAGE': 'en_US:en', 08:05:15 INFO - 'LOGNAME': 'cltbld', 08:05:15 INFO - 'MAIL': '/var/mail/cltbld', 08:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:15 INFO - 'MOZ_NO_REMOTE': '1', 08:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:15 INFO - 'NO_EM_RESTART': '1', 08:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:05:15 INFO - 'PWD': '/builds/slave/test-pgo', 08:05:15 INFO - 'SHELL': '/bin/bash', 08:05:15 INFO - 'SHLVL': '1', 08:05:15 INFO - 'TERM': 'linux', 08:05:15 INFO - 'TMOUT': '86400', 08:05:15 INFO - 'USER': 'cltbld', 08:05:15 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', 08:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:15 INFO - '_': '/tools/buildbot/bin/python'} 08:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:05:15 INFO - Downloading/unpacking flake8 08:05:15 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:05:15 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:05:15 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:05:15 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:05:15 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:05:15 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:05:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:05:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:05:17 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:05:17 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:05:17 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:05:17 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:05:17 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:05:17 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:05:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:05:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:05:17 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:05:17 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:05:17 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:05:17 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:05:17 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:05:17 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:05:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:05:17 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:05:17 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:05:17 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:05:17 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:05:17 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:05:17 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:05:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 08:05:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:05:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:05:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:05:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:05:17 INFO - no previously-included directories found matching 'docs/_build' 08:05:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:05:17 INFO - Running setup.py install for pep8 08:05:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:05:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:05:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:05:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:05:17 INFO - no previously-included directories found matching 'docs/_build' 08:05:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 08:05:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:05:17 INFO - Cleaning up... 08:05:17 INFO - Return code: 0 08:05:17 INFO - Running post-action listener: _resource_record_post_action 08:05:17 INFO - Running post-action listener: _start_resource_monitoring 08:05:18 INFO - Starting resource monitoring. 08:05:18 INFO - ##### 08:05:18 INFO - ##### Running install step. 08:05:18 INFO - ##### 08:05:18 INFO - Running pre-action listener: _resource_record_pre_action 08:05:18 INFO - Running main action method: install 08:05:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 08:05:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 08:05:18 INFO - Reading from file tmpfile_stdout 08:05:18 INFO - Detecting whether we're running mozinstall >=1.0... 08:05:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 08:05:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 08:05:18 INFO - Reading from file tmpfile_stdout 08:05:18 INFO - Output received: 08:05:18 INFO - Usage: mozinstall [options] installer 08:05:18 INFO - Options: 08:05:18 INFO - -h, --help show this help message and exit 08:05:18 INFO - -d DEST, --destination=DEST 08:05:18 INFO - Directory to install application into. [default: 08:05:18 INFO - "/builds/slave/test-pgo"] 08:05:18 INFO - --app=APP Application being installed. [default: firefox] 08:05:18 INFO - mkdir: /builds/slave/test-pgo/build/application 08:05:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 08:05:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 08:05:34 INFO - Reading from file tmpfile_stdout 08:05:34 INFO - Output received: 08:05:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 08:05:34 INFO - Running post-action listener: _resource_record_post_action 08:05:34 INFO - ##### 08:05:34 INFO - ##### Running run-tests step. 08:05:34 INFO - ##### 08:05:34 INFO - Running pre-action listener: _resource_record_pre_action 08:05:34 INFO - Running main action method: run_tests 08:05:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 08:05:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 08:05:34 INFO - Python 2.7.3 08:05:34 INFO - Return code: 0 08:05:34 INFO - grabbing minidump binary from tooltool 08:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:05:34 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 0x1852840>, '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 0x17bf6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17bfb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 08:05:34 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:05:34 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:05:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:05:34 INFO - Return code: 0 08:05:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 08:05:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 08:05:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 08:05:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 08:05:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 08:05:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 08:05:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 08:05:35 INFO - Return code: 0 08:05:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 08:05:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 08:05:35 INFO - Using env: {'DISPLAY': ':0', 08:05:35 INFO - 'HOME': '/home/cltbld', 08:05:35 INFO - 'LANG': 'en_US.UTF-8', 08:05:35 INFO - 'LANGUAGE': 'en_US:en', 08:05:35 INFO - 'LOGNAME': 'cltbld', 08:05:35 INFO - 'MAIL': '/var/mail/cltbld', 08:05:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:05:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 08:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:05:35 INFO - 'MOZ_NO_REMOTE': '1', 08:05:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 08:05:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:05:35 INFO - 'NO_EM_RESTART': '1', 08:05:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 08:05:35 INFO - 'PWD': '/builds/slave/test-pgo', 08:05:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 08:05:35 INFO - 'SHELL': '/bin/bash', 08:05:35 INFO - 'SHLVL': '1', 08:05:35 INFO - 'TERM': 'linux', 08:05:35 INFO - 'TMOUT': '86400', 08:05:35 INFO - 'USER': 'cltbld', 08:05:35 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002', 08:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:05:35 INFO - '_': '/tools/buildbot/bin/python'} 08:05:35 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:05:35 INFO - mozversion application_buildid: 20160125053002 08:05:35 INFO - mozversion application_changeset: 671e1d2fe00379370df4f14f1fb7396f8eae2877 08:05:35 INFO - mozversion application_display_name: Nightly 08:05:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:05:35 INFO - mozversion application_name: Firefox 08:05:35 INFO - mozversion application_remotingname: firefox 08:05:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 08:05:35 INFO - mozversion application_vendor: Mozilla 08:05:35 INFO - mozversion application_version: 46.0a1 08:05:35 INFO - mozversion platform_buildid: 20160125053002 08:05:35 INFO - mozversion platform_changeset: 671e1d2fe00379370df4f14f1fb7396f8eae2877 08:05:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 08:05:35 INFO - mozversion platform_version: 46.0a1 08:05:35 INFO - using testdate: 1453737935 08:05:35 INFO - actual date: 1453737935 08:05:35 INFO - starting webserver on 'localhost:39847' 08:05:35 INFO - SUITE-START | Running 3 tests 08:05:35 INFO - TEST-START | dromaeo_css 08:05:35 INFO - operating with platform_type : linux_ 08:05:35 INFO - Initialising browser for dromaeo_css test... 08:05:35 INFO - TEST-INFO | started process 6639 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpimzlds/profile http://localhost:39847/getInfo.html) 08:05:39 INFO - PROCESS | 6639 | __metrics Screen width/height:1600/1200 08:05:39 INFO - PROCESS | 6639 | colorDepth:24 08:05:39 INFO - PROCESS | 6639 | Browser inner width/height: 1024/697 08:05:39 INFO - PROCESS | 6639 | __metrics 08:05:40 INFO - PROCESS | 6639 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:05:40 INFO - PROCESS | 6639 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:05:41 INFO - TEST-INFO | 6639: exit 0 08:05:41 INFO - Browser initialized. 08:05:41 INFO - Running cycle 1/1 for dromaeo_css test... 08:05:41 INFO - TEST-INFO | started process 6730 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpimzlds/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:05:52 INFO - PROCESS | 6730 | RSS: Main: 148312064 08:05:52 INFO - PROCESS | 6730 | 08:06:44 INFO - PROCESS | 6730 | 1453738004347 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:08:52 INFO - PROCESS | 6730 | Cycle 1(1): loaded http://localhost:39847/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39847/tests/dromaeo/cssquery-ext.html) 08:08:53 INFO - PROCESS | 6730 | RSS: Main: 269803520 08:08:53 INFO - PROCESS | 6730 | 08:11:56 INFO - PROCESS | 6730 | Cycle 1(1): loaded http://localhost:39847/tests/dromaeo/cssquery-ext.html (next: http://localhost:39847/tests/dromaeo/cssquery-jquery.html) 08:11:56 INFO - PROCESS | 6730 | RSS: Main: 237502464 08:11:56 INFO - PROCESS | 6730 | 08:14:58 INFO - PROCESS | 6730 | Cycle 1(1): loaded http://localhost:39847/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39847/tests/dromaeo/cssquery-mootools.html) 08:14:59 INFO - PROCESS | 6730 | RSS: Main: 237289472 08:14:59 INFO - PROCESS | 6730 | 08:18:01 INFO - PROCESS | 6730 | Cycle 1(1): loaded http://localhost:39847/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39847/tests/dromaeo/cssquery-prototype.html) 08:18:01 INFO - PROCESS | 6730 | RSS: Main: 212533248 08:18:01 INFO - PROCESS | 6730 | 08:21:04 INFO - PROCESS | 6730 | Cycle 1(1): loaded http://localhost:39847/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39847/tests/dromaeo/cssquery-yui.html) 08:21:04 INFO - PROCESS | 6730 | RSS: Main: 216776704 08:21:04 INFO - PROCESS | 6730 | 08:24:07 INFO - PROCESS | 6730 | Cycle 1(1): loaded http://localhost:39847/tests/dromaeo/cssquery-yui.html (next: http://localhost:39847/tests/dromaeo/cssquery-dojo.html) 08:24:07 INFO - PROCESS | 6730 | RSS: Main: 300392448 08:24:07 INFO - PROCESS | 6730 | 08:24:07 INFO - PROCESS | 6730 | __start_tp_report 08:24:07 INFO - PROCESS | 6730 | _x_x_mozilla_page_load 08:24:07 INFO - PROCESS | 6730 | _x_x_mozilla_page_load_details 08:24:07 INFO - PROCESS | 6730 | |i|pagename|runs| 08:24:07 INFO - PROCESS | 6730 | |0;dojo.html;3063.7395821355185;3066.75465962723;3115.532670099486;3117.4700300948834;3139.152428844213;4979.053979743846;5008.749562521877;5017.924731129031;5038.345015148035;5059.822906198279;4960.6031517478605;4972.7762250698715;5018.222175562784;5022.447530771612;5045.77294021769;4540.90918181637;4581.839635612754;4613.100445413146;4634.814607415699;4688.5077066908;4693.6949098308505;4726.149293127236;4735.076660051292;4744.596709279698;4744.928826067612;4519.367288579601;4520.095980803836;4572.017016341502;4591.4260717410325;4608.423947006624;4551.658625603093;4558.931616025729;4560.543945605413;4581.427321584802;4610.792514336863;4522.932156017662;4534.229181039198;4535.63714902807;4536.02475467776;4589.931151032737;4776.259679749644;4838.104950584118;4908.754562271908;4972.651914365996;4973.776180071905;5286.920696189561;5304.946950530522;5316.840494785162;5323.733813309319;5331.1470164773455;5355.544778693816;5355.544778693816;5365;5405.108157154064;5426.131818908995;5063.291139240509;5089.974550127263;5092.9236061459105;5164.483551644843;5180.0157969985585;5529.474699903502;5529.917051244234;5532.28080349552;5535.972320138373;5582.27430434041;5330.946690533045;5334.839954801285;5335.733213339317;5336.626436149432;5337.86655333612;5289.206619007103;5354.705491198021;5378.11261141915;5441.047816632153;5482.205080263339;5416.160495123262;5445.128779395278;5452.727363631802;5455.181722741541;5457.399686034533;5252.842414727565;5400.91898621521;5428.321459817523;5455.318085239345;5502.779888804483;4194.2869712148395;4220.704550681484;4226.049138943713;4233.97883010583;4240.872773816791;3808.638179372955;3820.2359528094494;3820.3887378019385;3850.6919446444217;3850.7497012694644;5050.621203409685;5056.342675452168;5062.240663900371;5063.11395505785;5097.8725531862;5346.893062138735;5369.27514785499;5391.865203369869;5417.729113544307;5434.076207044812;4973.925391119136;5008.799648014038;5008.924866127011;5010.3737032870895;5053.84838454847;4590.081983603292;4648.581627653527;4649.023705021983;4662.603678687349;4679.67242293043;5356.544693701079;5460.808871689551;5482.424345443751;5498.8075417361;5547.057000309957;5350.5184533392185;5359.356877174764;5360.973195133999;5374.623776335619;5380.273663055594;5501.587380946525;5526.585506086979;5531.170324451365;5554.611177217556;5575.330960284792;5298.046351656584;5301.973490132525;5319.893602128013;5321.042212401805;5371.946280537145;5389.461053894579;5423.3491980962535;5432.239486471976;5435.718302009826;5481.75332110048;5129.076766182123;5154.458781827854;5160.071187186342;5299.973500132474;5309.946900531099;5268.894622107613;5280.551153151871;5284.550813180923;5292.444293349143;5316.096263635269;5195.506426889439;5197.312764369246;5199.92200116991;5208.401033881;5235.476452354734;5250.474952504719;5270.8155214567305;5315.069862774077;5325.2810870531985;5327.6803391795065;5249.055170069424;5249.527542521191;5250.212468129811;5255.579553635776;5267.78928842842 08:24:07 INFO - PROCESS | 6730 | |1;ext.html;536.9301990741203;537.74188389573;558.9832305030848;563.3633993587247;585.2012003615067;27471.725282747168;27920.72079279209;34298.485522717114;34877.65122348776;34976.650233497654;37635;38088.42867356985;38145;38159.618403815955;38160;8144.4298899077085;8352.498850068985;8355.749327520154;8356.080831108573;8356.791080222982;8321.375896807733;8415.537145457029;8447.493150410965;8462.74611761645;8471;8396.202360775716;8453.788655283637;8472.15278472154;8472.364572657045;8486.405951583392;8260.380471464634;8412.1587841216;8412.453190542656;8418.074011858691;8440.198181172778;8247.340212782963;8331.33349332052;8351.24838764514;8354.665813367457;8360.874586881202;36712.082197945;37235;37452.62547374519;37470.06324841874;37489.43765843515;2965.4513914925806;3047.9390412191856;3059.143439836849;3065.2949821540947;3194.34515924235;28124.437511249864;28828.567571486445;29062;29083.41833163346;29288.121356359345;3478.2521757821937;3492.406290930548;3602.3875941089814;3694.131879008431;3695.815209239527;249677;249684;249980;250046;250332;48925.266121008215;49598.75200624046;53258.73370633122;53419;53619;57520.4247957515;59333.40666593365;59474;59589.70205148947;59675.701621491615;13460.93269533646;13465.932670336586;13547.932260338635;13554.322283885766;13562.321883905764;9274.814503709888;9569.760755981157;9718.368306060083;9818.90181098194;10851.728706782395;17832.286708531512;17954;18095.095245237684;18104.185311661007;18133.727994080098;7168.92831071693;7508.324250817453;7561.735339263099;7581.12817026038;7596.24037596247;917.7934964632905;951.219999600335;974.3179774158118;1063.5586231713753;1145.8109411947103;24044.27867163988;25287.241382758548;26398.41609503436;26657.73342266591;26840.194794156207;1008.4302369161401;1017.7862648843677;1027.7071034755058;1070.71626019105;1093.2292733622776;12903.870961290268;13284.667883302995;13655.863441365658;13775.242361670003;13775.586732398044;312152;313252;314859;315099;315905;49842.75078624584;50104.24843627348;50218.748906255234;50265.24602130971;50309;1345.2869978911192;1356.3015047250674;1372.0601388049217;1374.924379159156;1379.379279324308;24117.397065073514;25579.744202557737;26081.608775867997;26169;26186.607200892384;41697.16605667809;41790.79104604458;42093;42132.57867421409;42138.57861421347;267464;271139;289881;293144;363888;29229.707702923548;29306.7069329304;29486.852565737034;29606.555901661923;29888.402231954806;40825.38761918633;40996.79501602473;41480;42251.57748422599;42475.3628695576;34329.48505772366;34790;34833;35138.824305878305;35808;31784.841075794473;31967;32260;32336.83831580827;32702.34595308128;31608.36783264368;32097.358052838346;32376.05743655388;32377.190570235933;32389.19027024343;27893.302667433476;28798.424031519673;30990.535141973338;31747.20631984219;31943.68056319407;23106.653400199346;23405.76594234036;23408.53182936366;24235.412625353238;24591.50816983686 08:24:07 INFO - PROCESS | 6730 | |2;jquery.html;350.40256362901255;354.81549594211026;357.97852128872256;364.2569158915812;367.49285985340225;13529.932350338235;13706.355237371505;15579.922100389496;16542.586435339123;17830.375936842214;14633.92683036586;15682.529524114267;15864;15971.600709982256;16733.414330498406;5321.813736519213;5528.226048353234;5531.308586426697;5531.529819965308;5532.529734972532;4006.83972641094;4131.194417088669;5393.7572809223675;5471.23402723619;5762.423757624246;5695.971520142393;5904.261967254093;5957.910631340512;5964.493018093467;5978.641281523101;5981.9700901495435;6052.425019623129;6060.636361818283;6064.666443345636;6068.878622427526;5082.110630639623;5230.372355317349;5232;5243;5252.763625636855;19696.80303196964;19826.504337391536;19973.600527989503;19977.30079447227;20122.29571964974;2054.0756659503136;2149.12960251097;2159.9028043737912;2387.6418537219383;2754;12655.367231638382;12703.428345724464;12860.485580576766;12999.545015924397;13132;1800.3518733256017;1802.152988095593;1839.4205825165163;1843.6404901044302;1855.3877220517331;37108.44337334942;52982.47017529853;54607.72696136533;54913.450865491635;56079.15881261785;9028.232600228923;9225;9225.953870230605;9250.629974801068;9261.073892610684;11854.94072529632;11871.347075910908;11878.940605296919;11892.643220703392;11905.583304584472;6859.862802743917;6872.312768723088;7002.40479559233;7055.541389809646;7128.322809333209;6835.350641689031;6889.414399775975;6892.310768923167;6921.826954326182;6927.134108236471;3975.185087057146;3975.588666023578;3980.5223373195404;3990;4003.619656132721;1615.3215649427268;1616.3938523053855;1651.4880387079804;1704.514213449161;1754.2807448946126;382.9655331020166;894.1594900793234;913.9131782480654;970.2819913264134;984.867042949207;9321.207697345802;9566.378185417925;9662.855057174149;9682.225421966366;9849.901500985041;397.2928187825675;403.7557277846919;404.3954288338952;410.05073255413623;416.7624454061217;5406.162044883049;5428.972855135699;5433.130699088127;5483.958047970873;5513.145462453326;482642;493779;495582;508786;514184;53366.466335336925;61723.89516624374;62036.37963620306;65460.01809972854;66132;1113.8886111388958;1142.6343570057668;1150.6605551362536;1159.2175281684829;1159.8028335182871;15096.24518774079;15252.923735381251;15374.846251537341;15410.614734631725;15609.141497217308;32952;33446.49830252597;33569.66430335665;33823.15442113967;33998.66001340054;35886.461703074994;40762;41480;42103.36844947389;42467.5753242476;7070.515191809777;7251.891221631785;7287.161976372785;7321.816954575965;7392.112946446246;9191.494467804068;10392.844107338246;10704.571817127227;10724.356538607708;11086.22396432242;8147.388945829205;8513.95743021281;8639.827203456021;8824.735257942271;9100.681476148304;8522;9145.451272923647;9354.111359420844;9442.291828113057;9708.75728106803;3619.5475565554307;8141.877871831809;8221.424500284922;8310.792230194293;8528.658853645784;7125.144982601913;7299.5620262784405;7368.37368823656;7370.189279179179;7372.96313518429;8460.153984601491;8728.738137855875;8751.474911505331;8836.91163088361;8840.823183536422 08:24:07 INFO - PROCESS | 6730 | |3;mootools.html;1323.9073264871463;1435.6554426937535;1454.5054681408321;1592.1720705233279;1778.084286592405;7089.32651398117;7635.083789945207;7811.023622047244;7817.687292508307;7818.609069546515;7594.316511513963;7736.7678969631;7767.456278060524;7768;7790.688372465094;2003.1086166655843;2058.135583055113;2058.6809044598112;2339.087755775249;2365.6333268343433;2072.253988564116;2290.2098775922364;2325.383773300077;2337.345543247885;2339.9649005264932;2298.816094712419;2318.9420264493356;2329.9184528541505;2330.650402439631;2358.351453350334;2205.106931692651;2229.2532001779423;2230.431240033789;2235.2065016918923;2243.461569223391;2283.817294616427;2285.7028586283677;2286.9085236590518;2287.1194590082773;2311.872846993415;7959.204079591995;8021.438499305051;8027.076886158108;8027.397945154137;8030.959845200737;4797.95202047982;4915.434725006634;4930.4330002049865;4935.35840340757;4935.605151587864;2948.071357522395;2998.925026874324;3018.5623084652602;3022.2595464111214;3024.6389124893667;919.3334832246568;922.5710044829186;923.1783712495884;969.4328817641688;1008.6873069348452;11173.21787474877;11283.435828208556;11296.039836613898;11320.150988675883;11322.32066076038;4430.269005614102;4512.3908272382805;4538.478075021349;4574.153781550423;4583.816647334069;9325.580348884316;9341.439513629204;9391.389559678599;9397.953010234905;9416.811663766686;4925.950740492621;4969.055879382906;4969.726665033458;4971.37857767779;4972.7513624318635;4478.417805685305;4515.0969806038265;4522.3668686383935;4525.298578720303;4526.388937493462;3429.1427143214196;3526.1360966563357;3680.4479328100465;3799.1072098056934;3829;1203.3983008495752;1206.149664486535;1212.1151559361715;1215.0461887418335;1218.8781121887741;1188.5305304404712;1226.1600803449664;1231.310466138965;1236.6290112966074;1237.2514628649537;7145.178304494945;7156.248593897566;7260.818479537948;7279.41764658826;7280.890786638205;1097.0620119797618;1097.5664612478026;1100.6940459736838;1102.9779404412027;1118.4854966715402;5775;5841.474267315877;5869.236999190078;5879.235699359056;5880.0297950838485;9530.856297244374;9695.22438204956;9941.055599718014;9957.950210248902;9962.551685174185;9643.566039528238;9656.613735450503;9742.75643108928;9768.560414781352;9781.119699226962;7205.963970180115;7414.8887766682465;7425.480216384801;7443.36731377839;7536.0956685198125;7134.607596582237;7203.927960720326;7211.891821622575;7213.531120477152;7220.133583969957;8125.553094579855;8338.124496927736;8527.74416767498;8533.871991920001;8547.700830470903;8483.703070392507;8531.488110713377;8555.31557475388;8559.61481733336;8751.824963500567;6714.899276510759;6794.082798822095;6802.421794147355;6816.182058153054;6817.181938167451;6730.528862979741;6848.623325716934;7439.776806695808;7507.549547027196;7510.812229694083;6650.900236496554;6686.498512611476;6711.362420570234;6738.898916516354;6835.521513494206;6661.533692641662;6709.630970296485;6717.227518835396;6818.488613354118;6910.447164226749;6817.079694241214;6823.590584564942;6837.794866154023;6879.6560171992205;6881.965590172217;6333.96833015832;6369.617822930639;6373.267074286331;6475.514336424692;6527;6480.481561475165;6594.571352862241;6616.470682345497;6625.138731964814;6631.33686631333 08:24:07 INFO - PROCESS | 6730 | |4;prototype.html;343.5722525455808;350.7054074577355;351.08016995471866;351.9894403167906;353.91682954505694;5830.067189249721;5863.149843272723;5877.529797616191;5905.143754155645;5918.260217472816;5523.502884740373;5591.692456914868;5673.943260567393;5772.163036359725;5798.478136967672;4449.888752781174;4465.910681786362;4480.395146655209;4485.327200919855;4485.887852803673;4299.935500967488;4462.12988467249;4468.352088947101;4472.955270447303;4480;4311.655067594585;4368.25739624263;4413.514513403523;4430.734155950637;4436.800343984512;4416.536263692315;4428.7121337112985;4429.822807087713;4436.401085853401;4437.0682156747125;3890.961090389088;3892.104815892332;3898.4542164097047;3899.8245078971513;3907.609239076098;5414.214938833887;5532.861678458071;5538.972305138489;5540.722963851832;5544.641562817135;5161.27742116104;5222.529972302473;5240.711760853152;5245.947540524584;5252.553532949704;6125.234345706786;6134.693265336716;6135.570510064297;6139.447449729501;6144.201253836973;4419.049904270565;4425.3140763181755;4430.202563538562;4432.913936085647;4435.600795928382;6309.310842083873;6337.429631333156;6406.871862562769;6410;6419;4421.093675796454;4448.1770872388715;4451.888702782391;4453.131639330364;4455.665825063068;4493.865184044418;4494.37078808967;4513.593776560126;4517.41273634432;4523.457185137739;5168.638195326291;5173.586113110942;5177.456367081478;5178.404483484447;5184.326037615086;6038.245219347582;6194.721237544321;6195.256569211723;6201.937980620136;6202.317745048041;1603.791507104069;1641.1137985487942;1641.4829328761402;1641.5239580521754;1642.0476123848377;1069.946502674863;1086.7717779266284;1087.950128126362;1089.1178145702006;1106.3417266726285;5896.115582662549;5897.2038774765715;5898.4101589840675;5898.997170481029;5906.704664766745;6319.115323854664;6338.683065846689;6341.460975817107;6346.809595712136;6351.333110023474;5676.858078548069;5767.250257466502;5787.826365209051;5871.3541510433815;5888.440598143169;3405.1146701857697;3418.3846907556876;3433.53647257617;3442.294329662413;3443.4318337474037;6577.158395649226;6582.539222254492;6591;6599.142111525471;6600.8349791255605;6395.104685344056;6520.641364724891;6572.835679107965;6573.276939536647;6575.835604109936;6605.438537724252;6610.305917878553;6610.8347291318105;6613.933860661332;6614.470842332602;6406.327335629878;6407.1350367701625;6410.61536307823;6414.069959855701;6416.647084410402;6122.877542449037;6349.841253968688;6376.362363763772;6378.2346118466085;6379.234491861006;6619.27188009309;6621.205455345389;6622.238442579165;6622.84100282439;6627.502937279627;4437.090396468651;4456.197884380843;4469.709468884512;4479.148961697267;4479.372887795646;6225.28409232944;6371.49028077762;6385.265694445013;6386.840328991812;6387.968060159669;6183.5671502994355;6233.563650544418;6238.064290356483;6239.126522286792;6242.250929888442;6223.253209614875;6230.719617617127;6243.500519958483;6253.155823963707;6255.593386429868;5948.910766338422;6120.296165940974;6132.38676132401;6144.078388241799;6155.569110162246;6265.749370025148;6271.4669253114;6274.46667033289;6285.717142728497;6285.905711414424;6122.571420000557;6134.478569321657;6139.815805525842;6139.938600613937;6143.631382117087 08:24:07 INFO - PROCESS | 6730 | |5;yui.html;691.4986634689849;760.1220590218296;763.7823220382193;765.3915137465714;765.506248469737;11403.714907127325;11484.196106272544;11520.481578328974;11525.19323647345;11541.422928853555;12091.153619246656;14555.781663275033;14794.778078328834;14794.852051479482;14811.259437028133;648.7923864363405;656.8751937131954;761.7105499910026;766.3371183925906;782.6126067596548;772.5596410046276;777.6539439949197;778.1168373895641;780.894579231805;781.3007358414216;807.5921659561913;810.1695761844128;810.5096416667919;811.2495941254346;811.4117264982899;667.6795138333579;677.5629718831351;799.9600019999006;811.5942028985507;813.5322189740923;593.1399470767404;596.8627215740361;601.3205078261581;601.4076135007015;601.6600620649319;13524.729505409836;13582.25297608631;13591.728165436636;13595.184288942695;13646.181229126285;10765.300255483447;10958.123350131971;11088.168387370979;11148.944255278753;11469;9467.774534022048;9854.704358869174;9986.151177149952;9992.750181245454;10017.549210285555;2841.176058942904;2887.364779748452;2904.6223990881263;2917.7374036336832;2923.1961210667023;45398.77300613476;45412.772936135436;45521;46010.76994615039;46016.30975535369;9228.169464748205;9269.258459323239;9294;9369.812603747887;9411.4823684698;16963;16966.066866322224;16974.915125424293;17012.234449449803;17051.91474042622;7180;7186.317299856505;7414.555126692416;7522.736704215326;7554.508956917783;4128.4632997710105;4232.32282834745;4349.108432771274;4366.956330436655;4503.617192538671;2871.1530098620956;2917.9124626261246;2929.487339715541;2931.9120426387244;2937.3390987028174;549.2557584472981;556.2573963758347;565.135342925325;569.8774763425884;569.9287589051369;576.1559315602663;583.4428121144297;598.1267349669445;626.7179769103922;637.4772686397109;8461.238488535939;8783.868241976375;8800.16398442147;8894;9024.458532488072;528.8307741522752;617.4658920034228;635.6630985577559;641.416311156845;647.7311915555086;3680.4663323817895;3700.8519659213866;3959.2675355059405;3993.84024639017;4086.8160932758096;53530;53627.19559206615;54126.72936635291;54212.72893635585;54355;49256.50743492591;49485.75257123763;49993;50227.24659130116;50382.748086260064;42889.78555107205;42896.571034289256;43197.35203971943;43749.78125109354;44230.77884610621;7976.441649084509;8209.09699932995;8242.917570824455;8266.966629171353;8291.295239904675;33042.33915321632;33581.160470987445;33715.3256934855;33719;34347;39296.607033930435;41917;42543.7872810634;42860;43036;9129.589168487566;9410.38832475887;9470.337076404585;9503.66737164196;9548.37935534188;10340.844887326846;10361.63734269297;10463.372197668165;10480.895191047992;10771.515281812493;9927.702168934944;10393.116585090353;10442.321249118782;10717.678469645924;10774.838377424188;9942.552585133542;10086.646967356108;10187;10192.898071019492;10276.39689799147;9281.257499400166;9418.993582914254;9601.47191904452;9662.71011869617;9844.409335439897;8446.239838414573;8570.749296667502;8628.180322869317;8926.107389261022;8962;8212.425130240827;8455.32357411418;8497.192766687154;8643.135686431306;8729 08:24:07 INFO - PROCESS | 6730 | __end_tp_report 08:24:07 INFO - PROCESS | 6730 | __start_cc_report 08:24:07 INFO - PROCESS | 6730 | _x_x_mozilla_cycle_collect,1033 08:24:07 INFO - PROCESS | 6730 | __end_cc_report 08:24:07 INFO - PROCESS | 6730 | __startTimestamp1453739047723__endTimestamp 08:24:07 INFO - PROCESS | 6730 | 08:24:07 INFO - PROCESS | 6730 | ------- Summary: start ------- 08:24:07 INFO - PROCESS | 6730 | Number of tests: 6 08:24:07 INFO - PROCESS | 6730 | 08:24:07 INFO - PROCESS | 6730 | [#0] dojo.html Cycles:165 Average:5015.91 Median:5235.48 stddev:528.38 (10.1%) stddev-sans-first:507.32 08:24:07 INFO - PROCESS | 6730 | Values: 3063.7 3066.8 3115.5 3117.5 3139.2 4979.1 5008.7 5017.9 5038.3 5059.8 4960.6 4972.8 5018.2 5022.4 5045.8 4540.9 4581.8 4613.1 4634.8 4688.5 4693.7 4726.1 4735.1 4744.6 4744.9 4519.4 4520.1 4572.0 4591.4 4608.4 4551.7 4558.9 4560.5 4581.4 4610.8 4522.9 4534.2 4535.6 4536.0 4589.9 4776.3 4838.1 4908.8 4972.7 4973.8 5286.9 5304.9 5316.8 5323.7 5331.1 5355.5 5355.5 5365.0 5405.1 5426.1 5063.3 5090.0 5092.9 5164.5 5180.0 5529.5 5529.9 5532.3 5536.0 5582.3 5330.9 5334.8 5335.7 5336.6 5337.9 5289.2 5354.7 5378.1 5441.0 5482.2 5416.2 5445.1 5452.7 5455.2 5457.4 5252.8 5400.9 5428.3 5455.3 5502.8 4194.3 4220.7 4226.0 4234.0 4240.9 3808.6 3820.2 3820.4 3850.7 3850.7 5050.6 5056.3 5062.2 5063.1 5097.9 5346.9 5369.3 5391.9 5417.7 5434.1 4973.9 5008.8 5008.9 5010.4 5053.8 4590.1 4648.6 4649.0 4662.6 4679.7 5356.5 5460.8 5482.4 5498.8 5547.1 5350.5 5359.4 5361.0 5374.6 5380.3 5501.6 5526.6 5531.2 5554.6 5575.3 5298.0 5302.0 5319.9 5321.0 5371.9 5389.5 5423.3 5432.2 5435.7 5481.8 5129.1 5154.5 5160.1 5300.0 5309.9 5268.9 5280.6 5284.6 5292.4 5316.1 5195.5 5197.3 5199.9 5208.4 5235.5 5250.5 5270.8 5315.1 5325.3 5327.7 5249.1 5249.5 5250.2 5255.6 5267.8 08:24:07 INFO - PROCESS | 6730 | 08:24:07 INFO - PROCESS | 6730 | [#1] ext.html Cycles:180 Average:44201.67 Median:18903.87 stddev:75757.68 (400.8%) stddev-sans-first:75899.26 08:24:07 INFO - PROCESS | 6730 | Values: 536.9 537.7 559.0 563.4 585.2 27471.7 27920.7 34298.5 34877.7 34976.7 37635.0 38088.4 38145.0 38159.6 38160.0 8144.4 8352.5 8355.7 8356.1 8356.8 8321.4 8415.5 8447.5 8462.7 8471.0 8396.2 8453.8 8472.2 8472.4 8486.4 8260.4 8412.2 8412.5 8418.1 8440.2 8247.3 8331.3 8351.2 8354.7 8360.9 36712.1 37235.0 37452.6 37470.1 37489.4 2965.5 3047.9 3059.1 3065.3 3194.3 28124.4 28828.6 29062.0 29083.4 29288.1 3478.3 3492.4 3602.4 3694.1 3695.8 249677.0 249684.0 249980.0 250046.0 250332.0 48925.3 49598.8 53258.7 53419.0 53619.0 57520.4 59333.4 59474.0 59589.7 59675.7 13460.9 13465.9 13547.9 13554.3 13562.3 9274.8 9569.8 9718.4 9818.9 10851.7 17832.3 17954.0 18095.1 18104.2 18133.7 7168.9 7508.3 7561.7 7581.1 7596.2 917.8 951.2 974.3 1063.6 1145.8 24044.3 25287.2 26398.4 26657.7 26840.2 1008.4 1017.8 1027.7 1070.7 1093.2 12903.9 13284.7 13655.9 13775.2 13775.6 312152.0 313252.0 314859.0 315099.0 315905.0 49842.8 50104.2 50218.7 50265.2 50309.0 1345.3 1356.3 1372.1 1374.9 1379.4 24117.4 25579.7 26081.6 26169.0 26186.6 41697.2 41790.8 42093.0 42132.6 42138.6 267464.0 271139.0 289881.0 293144.0 363888.0 29229.7 29306.7 29486.9 29606.6 29888.4 40825.4 40996.8 41480.0 42251.6 42475.4 34329.5 34790.0 34833.0 35138.8 35808.0 31784.8 31967.0 32260.0 32336.8 32702.3 31608.4 32097.4 32376.1 32377.2 32389.2 27893.3 28798.4 30990.5 31747.2 31943.7 23106.7 23405.8 23408.5 24235.4 24591.5 08:24:07 INFO - PROCESS | 6730 | 08:24:07 INFO - PROCESS | 6730 | [#2] jquery.html Cycles:180 Average:25400.87 Median:5231.19 stddev:81466.00 (1557.3%) stddev-sans-first:81672.81 08:24:07 INFO - PROCESS | 6730 | Values: 350.4 354.8 358.0 364.3 367.5 13529.9 13706.4 15579.9 16542.6 17830.4 14633.9 15682.5 15864.0 15971.6 16733.4 5321.8 5528.2 5531.3 5531.5 5532.5 4006.8 4131.2 5393.8 5471.2 5762.4 5696.0 5904.3 5957.9 5964.5 5978.6 5982.0 6052.4 6060.6 6064.7 6068.9 5082.1 5230.4 5232.0 5243.0 5252.8 19696.8 19826.5 19973.6 19977.3 20122.3 2054.1 2149.1 2159.9 2387.6 2754.0 12655.4 12703.4 12860.5 12999.5 13132.0 1800.4 1802.2 1839.4 1843.6 1855.4 37108.4 52982.5 54607.7 54913.5 56079.2 9028.2 9225.0 9226.0 9250.6 9261.1 11854.9 11871.3 11878.9 11892.6 11905.6 6859.9 6872.3 7002.4 7055.5 7128.3 6835.4 6889.4 6892.3 6921.8 6927.1 3975.2 3975.6 3980.5 3990.0 4003.6 1615.3 1616.4 1651.5 1704.5 1754.3 383.0 894.2 913.9 970.3 984.9 9321.2 9566.4 9662.9 9682.2 9849.9 397.3 403.8 404.4 410.1 416.8 5406.2 5429.0 5433.1 5484.0 5513.1 482642.0 493779.0 495582.0 508786.0 514184.0 53366.5 61723.9 62036.4 65460.0 66132.0 1113.9 1142.6 1150.7 1159.2 1159.8 15096.2 15252.9 15374.8 15410.6 15609.1 32952.0 33446.5 33569.7 33823.2 33998.7 35886.5 40762.0 41480.0 42103.4 42467.6 7070.5 7251.9 7287.2 7321.8 7392.1 9191.5 10392.8 10704.6 10724.4 11086.2 8147.4 8514.0 8639.8 8824.7 9100.7 8522.0 9145.5 9354.1 9442.3 9708.8 3619.5 8141.9 8221.4 8310.8 8528.7 7125.1 7299.6 7368.4 7370.2 7373.0 8460.2 8728.7 8751.5 8836.9 8840.8 08:24:07 INFO - PROCESS | 6730 | 08:24:07 INFO - PROCESS | 6730 | [#3] mootools.html Cycles:180 Average:5511.77 Median:6503.74 stddev:2883.14 (44.3%) stddev-sans-first:2874.04 08:24:07 INFO - PROCESS | 6730 | Values: 1323.9 1435.7 1454.5 1592.2 1778.1 7089.3 7635.1 7811.0 7817.7 7818.6 7594.3 7736.8 7767.5 7768.0 7790.7 2003.1 2058.1 2058.7 2339.1 2365.6 2072.3 2290.2 2325.4 2337.3 2340.0 2298.8 2318.9 2329.9 2330.7 2358.4 2205.1 2229.3 2230.4 2235.2 2243.5 2283.8 2285.7 2286.9 2287.1 2311.9 7959.2 8021.4 8027.1 8027.4 8031.0 4798.0 4915.4 4930.4 4935.4 4935.6 2948.1 2998.9 3018.6 3022.3 3024.6 919.3 922.6 923.2 969.4 1008.7 11173.2 11283.4 11296.0 11320.2 11322.3 4430.3 4512.4 4538.5 4574.2 4583.8 9325.6 9341.4 9391.4 9398.0 9416.8 4926.0 4969.1 4969.7 4971.4 4972.8 4478.4 4515.1 4522.4 4525.3 4526.4 3429.1 3526.1 3680.4 3799.1 3829.0 1203.4 1206.1 1212.1 1215.0 1218.9 1188.5 1226.2 1231.3 1236.6 1237.3 7145.2 7156.2 7260.8 7279.4 7280.9 1097.1 1097.6 1100.7 1103.0 1118.5 5775.0 5841.5 5869.2 5879.2 5880.0 9530.9 9695.2 9941.1 9958.0 9962.6 9643.6 9656.6 9742.8 9768.6 9781.1 7206.0 7414.9 7425.5 7443.4 7536.1 7134.6 7203.9 7211.9 7213.5 7220.1 8125.6 8338.1 8527.7 8533.9 8547.7 8483.7 8531.5 8555.3 8559.6 8751.8 6714.9 6794.1 6802.4 6816.2 6817.2 6730.5 6848.6 7439.8 7507.5 7510.8 6650.9 6686.5 6711.4 6738.9 6835.5 6661.5 6709.6 6717.2 6818.5 6910.4 6817.1 6823.6 6837.8 6879.7 6882.0 6334.0 6369.6 6373.3 6475.5 6527.0 6480.5 6594.6 6616.5 6625.1 6631.3 08:24:07 INFO - PROCESS | 6730 | 08:24:07 INFO - PROCESS | 6730 | [#4] prototype.html Cycles:180 Average:5182.69 Median:5874.44 stddev:1544.83 (26.3%) stddev-sans-first:1505.86 08:24:07 INFO - PROCESS | 6730 | Values: 343.6 350.7 351.1 352.0 353.9 5830.1 5863.1 5877.5 5905.1 5918.3 5523.5 5591.7 5673.9 5772.2 5798.5 4449.9 4465.9 4480.4 4485.3 4485.9 4299.9 4462.1 4468.4 4473.0 4480.0 4311.7 4368.3 4413.5 4430.7 4436.8 4416.5 4428.7 4429.8 4436.4 4437.1 3891.0 3892.1 3898.5 3899.8 3907.6 5414.2 5532.9 5539.0 5540.7 5544.6 5161.3 5222.5 5240.7 5245.9 5252.6 6125.2 6134.7 6135.6 6139.4 6144.2 4419.0 4425.3 4430.2 4432.9 4435.6 6309.3 6337.4 6406.9 6410.0 6419.0 4421.1 4448.2 4451.9 4453.1 4455.7 4493.9 4494.4 4513.6 4517.4 4523.5 5168.6 5173.6 5177.5 5178.4 5184.3 6038.2 6194.7 6195.3 6201.9 6202.3 1603.8 1641.1 1641.5 1641.5 1642.0 1069.9 1086.8 1088.0 1089.1 1106.3 5896.1 5897.2 5898.4 5899.0 5906.7 6319.1 6338.7 6341.5 6346.8 6351.3 5676.9 5767.3 5787.8 5871.4 5888.4 3405.1 3418.4 3433.5 3442.3 3443.4 6577.2 6582.5 6591.0 6599.1 6600.8 6395.1 6520.6 6572.8 6573.3 6575.8 6605.4 6610.3 6610.8 6613.9 6614.5 6406.3 6407.1 6410.6 6414.1 6416.6 6122.9 6349.8 6376.4 6378.2 6379.2 6619.3 6621.2 6622.2 6622.8 6627.5 4437.1 4456.2 4469.7 4479.1 4479.4 6225.3 6371.5 6385.3 6386.8 6388.0 6183.6 6233.6 6238.1 6239.1 6242.3 6223.3 6230.7 6243.5 6253.2 6255.6 5948.9 6120.3 6132.4 6144.1 6155.6 6265.7 6271.5 6274.5 6285.7 6285.9 6122.6 6134.5 6139.8 6139.9 6143.6 08:24:07 INFO - PROCESS | 6730 | 08:24:07 INFO - PROCESS | 6730 | [#5] yui.html Cycles:180 Average:12969.31 Median:552.76 stddev:15160.68 (2742.7%) stddev-sans-first:15175.17 08:24:07 INFO - PROCESS | 6730 | Values: 691.5 760.1 763.8 765.4 765.5 11403.7 11484.2 11520.5 11525.2 11541.4 12091.2 14555.8 14794.8 14794.9 14811.3 648.8 656.9 761.7 766.3 782.6 772.6 777.7 778.1 780.9 781.3 807.6 810.2 810.5 811.2 811.4 667.7 677.6 800.0 811.6 813.5 593.1 596.9 601.3 601.4 601.7 13524.7 13582.3 13591.7 13595.2 13646.2 10765.3 10958.1 11088.2 11148.9 11469.0 9467.8 9854.7 9986.2 9992.8 10017.5 2841.2 2887.4 2904.6 2917.7 2923.2 45398.8 45412.8 45521.0 46010.8 46016.3 9228.2 9269.3 9294.0 9369.8 9411.5 16963.0 16966.1 16974.9 17012.2 17051.9 7180.0 7186.3 7414.6 7522.7 7554.5 4128.5 4232.3 4349.1 4367.0 4503.6 2871.2 2917.9 2929.5 2931.9 2937.3 549.3 556.3 565.1 569.9 569.9 576.2 583.4 598.1 626.7 637.5 8461.2 8783.9 8800.2 8894.0 9024.5 528.8 617.5 635.7 641.4 647.7 3680.5 3700.9 3959.3 3993.8 4086.8 53530.0 53627.2 54126.7 54212.7 54355.0 49256.5 49485.8 49993.0 50227.2 50382.7 42889.8 42896.6 43197.4 43749.8 44230.8 7976.4 8209.1 8242.9 8267.0 8291.3 33042.3 33581.2 33715.3 33719.0 34347.0 39296.6 41917.0 42543.8 42860.0 43036.0 9129.6 9410.4 9470.3 9503.7 9548.4 10340.8 10361.6 10463.4 10480.9 10771.5 9927.7 10393.1 10442.3 10717.7 10774.8 9942.6 10086.6 10187.0 10192.9 10276.4 9281.3 9419.0 9601.5 9662.7 9844.4 8446.2 8570.7 8628.2 8926.1 8962.0 8212.4 8455.3 8497.2 8643.1 8729.0 08:24:07 INFO - PROCESS | 6730 | -------- Summary: end -------- 08:24:07 INFO - PROCESS | 6730 | 08:24:08 INFO - TEST-INFO | 6730: exit 0 08:24:08 INFO - TEST-OK | dromaeo_css | took 1112708ms 08:24:08 INFO - TEST-START | kraken 08:24:08 INFO - operating with platform_type : linux_ 08:24:08 INFO - Initialising browser for kraken test... 08:24:08 INFO - TEST-INFO | started process 6930 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp74rAzy/profile http://localhost:39847/getInfo.html) 08:24:12 INFO - PROCESS | 6930 | __metrics Screen width/height:1600/1200 08:24:12 INFO - PROCESS | 6930 | colorDepth:24 08:24:12 INFO - PROCESS | 6930 | Browser inner width/height: 1024/697 08:24:12 INFO - PROCESS | 6930 | __metrics 08:24:12 INFO - PROCESS | 6930 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:24:12 INFO - PROCESS | 6930 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:24:13 INFO - TEST-INFO | 6930: exit 0 08:24:13 INFO - Browser initialized. 08:24:13 INFO - Running cycle 1/1 for kraken test... 08:24:13 INFO - TEST-INFO | started process 7010 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp74rAzy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:24:25 INFO - PROCESS | 7010 | RSS: Main: 148393984 08:24:25 INFO - PROCESS | 7010 | 08:24:27 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:39847/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39847/tests/kraken/driver.html?testName=audio-beat-detection) 08:24:28 INFO - PROCESS | 7010 | RSS: Main: 188596224 08:24:28 INFO - PROCESS | 7010 | 08:24:31 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:39847/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39847/tests/kraken/driver.html?testName=audio-dft) 08:24:31 INFO - PROCESS | 7010 | RSS: Main: 178614272 08:24:31 INFO - PROCESS | 7010 | 08:24:34 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:39847/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39847/tests/kraken/driver.html?testName=audio-fft) 08:24:35 INFO - PROCESS | 7010 | RSS: Main: 162816000 08:24:35 INFO - PROCESS | 7010 | 08:24:37 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:39847/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39847/tests/kraken/driver.html?testName=audio-oscillator) 08:24:37 INFO - PROCESS | 7010 | RSS: Main: 166961152 08:24:37 INFO - PROCESS | 7010 | 08:24:40 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:39847/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39847/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:24:40 INFO - PROCESS | 7010 | RSS: Main: 168591360 08:24:40 INFO - PROCESS | 7010 | 08:24:43 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:39847/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39847/tests/kraken/driver.html?testName=imaging-darkroom) 08:24:44 INFO - PROCESS | 7010 | RSS: Main: 166240256 08:24:44 INFO - PROCESS | 7010 | 08:24:47 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:39847/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39847/tests/kraken/driver.html?testName=imaging-desaturate) 08:24:48 INFO - PROCESS | 7010 | RSS: Main: 167305216 08:24:48 INFO - PROCESS | 7010 | 08:24:50 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:39847/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39847/tests/kraken/driver.html?testName=json-parse-financial) 08:24:51 INFO - PROCESS | 7010 | RSS: Main: 169656320 08:24:51 INFO - PROCESS | 7010 | 08:24:53 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:39847/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39847/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:24:53 INFO - PROCESS | 7010 | RSS: Main: 182710272 08:24:53 INFO - PROCESS | 7010 | 08:24:55 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:39847/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39847/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:24:56 INFO - PROCESS | 7010 | RSS: Main: 180703232 08:24:56 INFO - PROCESS | 7010 | 08:24:58 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:39847/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39847/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:24:58 INFO - PROCESS | 7010 | RSS: Main: 190443520 08:24:58 INFO - PROCESS | 7010 | 08:25:01 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:39847/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:25:01 INFO - PROCESS | 7010 | RSS: Main: 197386240 08:25:01 INFO - PROCESS | 7010 | 08:25:04 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:39847/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:25:04 INFO - PROCESS | 7010 | RSS: Main: 197308416 08:25:04 INFO - PROCESS | 7010 | 08:25:06 INFO - PROCESS | 7010 | Cycle 1(1): loaded http://localhost:39847/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39847/tests/kraken/driver.html?testName=ai-astar) 08:25:06 INFO - PROCESS | 7010 | RSS: Main: 257400832 08:25:06 INFO - PROCESS | 7010 | 08:25:06 INFO - PROCESS | 7010 | __start_tp_report 08:25:06 INFO - PROCESS | 7010 | _x_x_mozilla_page_load 08:25:06 INFO - PROCESS | 7010 | _x_x_mozilla_page_load_details 08:25:06 INFO - PROCESS | 7010 | |i|pagename|runs| 08:25:06 INFO - PROCESS | 7010 | |0;ai-astar;110;110;104;109;110;110;109;109;104;108 08:25:06 INFO - PROCESS | 7010 | |1;audio-beat-detection;160;127;167;160;125;151;148;135;170;125 08:25:06 INFO - PROCESS | 7010 | |2;audio-dft;159;161;160;160;160;161;163;160;161;160 08:25:06 INFO - PROCESS | 7010 | |3;audio-fft;75;83;127;93;72;73;73;109;108;75 08:25:06 INFO - PROCESS | 7010 | |4;audio-oscillator;97;95;157;96;95;95;140;99;95;141 08:25:06 INFO - PROCESS | 7010 | |5;imaging-gaussian-blur;109;110;110;110;110;109;110;110;109;109 08:25:06 INFO - PROCESS | 7010 | |6;imaging-darkroom;145;145;145;145;145;145;144;145;145;145 08:25:06 INFO - PROCESS | 7010 | |7;imaging-desaturate;96;96;96;96;96;97;97;96;97;96 08:25:06 INFO - PROCESS | 7010 | |8;json-parse-financial;56;56;55;56;56;55;54;55;56;54 08:25:06 INFO - PROCESS | 7010 | |9;json-stringify-tinderbox;66;67;66;67;67;69;67;70;67;68 08:25:06 INFO - PROCESS | 7010 | |10;stanford-crypto-aes;81;83;82;82;82;84;84;84;82;84 08:25:06 INFO - PROCESS | 7010 | |11;stanford-crypto-ccm;115;116;126;118;118;115;123;112;112;115 08:25:06 INFO - PROCESS | 7010 | |12;stanford-crypto-pbkdf2;142;149;144;139;136;131;139;152;144;150 08:25:06 INFO - PROCESS | 7010 | |13;stanford-crypto-sha256-iterative;66;65;67;70;65;67;65;66;68;65 08:25:06 INFO - PROCESS | 7010 | __end_tp_report 08:25:06 INFO - PROCESS | 7010 | __start_cc_report 08:25:06 INFO - PROCESS | 7010 | _x_x_mozilla_cycle_collect,931 08:25:06 INFO - PROCESS | 7010 | __end_cc_report 08:25:06 INFO - PROCESS | 7010 | __startTimestamp1453739106662__endTimestamp 08:25:06 INFO - PROCESS | 7010 | 08:25:06 INFO - PROCESS | 7010 | ------- Summary: start ------- 08:25:06 INFO - PROCESS | 7010 | Number of tests: 14 08:25:06 INFO - PROCESS | 7010 | 08:25:06 INFO - PROCESS | 7010 | [#0] ai-astar Cycles:10 Average:108.30 Median:109.50 stddev:2.36 (2.2%) stddev-sans-first:2.42 08:25:06 INFO - PROCESS | 7010 | Values: 110.0 110.0 104.0 109.0 110.0 110.0 109.0 109.0 104.0 108.0 08:25:06 INFO - PROCESS | 7010 | 08:25:06 INFO - PROCESS | 7010 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:155.50 stddev:17.62 (11.3%) stddev-sans-first:18.03 08:25:06 INFO - PROCESS | 7010 | Values: 160.0 127.0 167.0 160.0 125.0 151.0 148.0 135.0 170.0 125.0 08:25:06 INFO - PROCESS | 7010 | 08:25:06 INFO - PROCESS | 7010 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:1.08 (0.7%) stddev-sans-first:1.00 08:25:06 INFO - PROCESS | 7010 | Values: 159.0 161.0 160.0 160.0 160.0 161.0 163.0 160.0 161.0 160.0 08:25:06 INFO - PROCESS | 7010 | 08:25:06 INFO - PROCESS | 7010 | [#3] audio-fft Cycles:10 Average:88.80 Median:74.00 stddev:19.58 (26.5%) stddev-sans-first:20.12 08:25:06 INFO - PROCESS | 7010 | Values: 75.0 83.0 127.0 93.0 72.0 73.0 73.0 109.0 108.0 75.0 08:25:06 INFO - PROCESS | 7010 | 08:25:06 INFO - PROCESS | 7010 | [#4] audio-oscillator Cycles:10 Average:111.00 Median:95.00 stddev:24.60 (25.9%) stddev-sans-first:25.56 08:25:06 INFO - PROCESS | 7010 | Values: 97.0 95.0 157.0 96.0 95.0 95.0 140.0 99.0 95.0 141.0 08:25:06 INFO - PROCESS | 7010 | 08:25:06 INFO - PROCESS | 7010 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 08:25:06 INFO - PROCESS | 7010 | Values: 109.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 109.0 109.0 08:25:06 INFO - PROCESS | 7010 | 08:25:06 INFO - PROCESS | 7010 | [#6] imaging-darkroom Cycles:10 Average:144.90 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:25:06 INFO - PROCESS | 7010 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 144.0 145.0 145.0 145.0 08:25:06 INFO - PROCESS | 7010 | 08:25:06 INFO - PROCESS | 7010 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:25:06 INFO - PROCESS | 7010 | Values: 96.0 96.0 96.0 96.0 96.0 97.0 97.0 96.0 97.0 96.0 08:25:06 INFO - PROCESS | 7010 | 08:25:06 INFO - PROCESS | 7010 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:56.00 stddev:0.82 (1.5%) stddev-sans-first:0.83 08:25:06 INFO - PROCESS | 7010 | Values: 56.0 56.0 55.0 56.0 56.0 55.0 54.0 55.0 56.0 54.0 08:25:06 INFO - PROCESS | 7010 | 08:25:06 INFO - PROCESS | 7010 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:1.26 (1.9%) stddev-sans-first:1.24 08:25:06 INFO - PROCESS | 7010 | Values: 66.0 67.0 66.0 67.0 67.0 69.0 67.0 70.0 67.0 68.0 08:25:06 INFO - PROCESS | 7010 | 08:25:06 INFO - PROCESS | 7010 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.50 stddev:1.14 (1.4%) stddev-sans-first:1.00 08:25:06 INFO - PROCESS | 7010 | Values: 81.0 83.0 82.0 82.0 82.0 84.0 84.0 84.0 82.0 84.0 08:25:06 INFO - PROCESS | 7010 | 08:25:06 INFO - PROCESS | 7010 | [#11] stanford-crypto-ccm Cycles:10 Average:117.00 Median:117.00 stddev:4.50 (3.8%) stddev-sans-first:4.71 08:25:06 INFO - PROCESS | 7010 | Values: 115.0 116.0 126.0 118.0 118.0 115.0 123.0 112.0 112.0 115.0 08:25:06 INFO - PROCESS | 7010 | 08:25:06 INFO - PROCESS | 7010 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.60 Median:144.00 stddev:6.60 (4.6%) stddev-sans-first:7.00 08:25:06 INFO - PROCESS | 7010 | Values: 142.0 149.0 144.0 139.0 136.0 131.0 139.0 152.0 144.0 150.0 08:25:06 INFO - PROCESS | 7010 | 08:25:06 INFO - PROCESS | 7010 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.65 (2.5%) stddev-sans-first:1.74 08:25:06 INFO - PROCESS | 7010 | Values: 66.0 65.0 67.0 70.0 65.0 67.0 65.0 66.0 68.0 65.0 08:25:06 INFO - PROCESS | 7010 | -------- Summary: end -------- 08:25:06 INFO - PROCESS | 7010 | 08:25:07 INFO - TEST-INFO | 7010: exit 0 08:25:07 INFO - TEST-OK | kraken | took 59179ms 08:25:07 INFO - TEST-START | v8_7 08:25:07 INFO - operating with platform_type : linux_ 08:25:07 INFO - Initialising browser for v8_7 test... 08:25:07 INFO - TEST-INFO | started process 7260 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsqzmjP/profile http://localhost:39847/getInfo.html) 08:25:11 INFO - PROCESS | 7260 | __metrics Screen width/height:1600/1200 08:25:11 INFO - PROCESS | 7260 | colorDepth:24 08:25:11 INFO - PROCESS | 7260 | Browser inner width/height: 1024/697 08:25:11 INFO - PROCESS | 7260 | __metrics 08:25:12 INFO - PROCESS | 7260 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:25:12 INFO - PROCESS | 7260 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:25:12 INFO - TEST-INFO | 7260: exit 0 08:25:12 INFO - Browser initialized. 08:25:12 INFO - Running cycle 1/1 for v8_7 test... 08:25:12 INFO - TEST-INFO | started process 7344 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpsqzmjP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:25:24 INFO - PROCESS | 7344 | RSS: Main: 148295680 08:25:24 INFO - PROCESS | 7344 | 08:25:47 INFO - PROCESS | 7344 | Cycle 1(1): loaded http://localhost:39847/tests/v8_7/run.html (next: http://localhost:39847/tests/v8_7/run.html) 08:25:47 INFO - PROCESS | 7344 | RSS: Main: 583663616 08:25:47 INFO - PROCESS | 7344 | 08:25:47 INFO - PROCESS | 7344 | __start_tp_report 08:25:47 INFO - PROCESS | 7344 | _x_x_mozilla_page_load 08:25:47 INFO - PROCESS | 7344 | _x_x_mozilla_page_load_details 08:25:47 INFO - PROCESS | 7344 | |i|pagename|runs| 08:25:47 INFO - PROCESS | 7344 | |0;Richards;167.47613465081227 08:25:47 INFO - PROCESS | 7344 | |1;DeltaBlue;189.82536066818528 08:25:47 INFO - PROCESS | 7344 | |2;Encrypt;279.4076557697681 08:25:47 INFO - PROCESS | 7344 | |3;Decrypt;5240.837696335078 08:25:47 INFO - PROCESS | 7344 | |4;RayTrace;1964.6365422396857 08:25:47 INFO - PROCESS | 7344 | |5;Earley;772.2007722007722 08:25:47 INFO - PROCESS | 7344 | |6;Boyer;12345.67901234568 08:25:47 INFO - PROCESS | 7344 | |7;RegExp;41224.489795918365 08:25:47 INFO - PROCESS | 7344 | |8;Splay;632.9113924050633 08:25:47 INFO - PROCESS | 7344 | |9;NavierStokes;4854.368932038835 08:25:47 INFO - PROCESS | 7344 | __end_tp_report 08:25:47 INFO - PROCESS | 7344 | __startTimestamp1453739147449__endTimestamp 08:25:47 INFO - PROCESS | 7344 | 08:25:47 INFO - PROCESS | 7344 | ------- Summary: start ------- 08:25:47 INFO - PROCESS | 7344 | Number of tests: 10 08:25:47 INFO - PROCESS | 7344 | 08:25:47 INFO - PROCESS | 7344 | [#0] Richards Cycles:1 Average:167.48 Median:167.48 stddev:0.00 (0.0%) 08:25:47 INFO - PROCESS | 7344 | Values: 167.5 08:25:47 INFO - PROCESS | 7344 | 08:25:47 INFO - PROCESS | 7344 | [#1] DeltaBlue Cycles:1 Average:189.83 Median:189.83 stddev:0.00 (0.0%) 08:25:47 INFO - PROCESS | 7344 | Values: 189.8 08:25:47 INFO - PROCESS | 7344 | 08:25:47 INFO - PROCESS | 7344 | [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 08:25:47 INFO - PROCESS | 7344 | Values: 279.4 08:25:47 INFO - PROCESS | 7344 | 08:25:47 INFO - PROCESS | 7344 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 08:25:47 INFO - PROCESS | 7344 | Values: 5240.8 08:25:47 INFO - PROCESS | 7344 | 08:25:47 INFO - PROCESS | 7344 | [#4] RayTrace Cycles:1 Average:1964.64 Median:1964.64 stddev:0.00 (0.0%) 08:25:47 INFO - PROCESS | 7344 | Values: 1964.6 08:25:47 INFO - PROCESS | 7344 | 08:25:47 INFO - PROCESS | 7344 | [#5] Earley Cycles:1 Average:772.20 Median:772.20 stddev:0.00 (0.0%) 08:25:47 INFO - PROCESS | 7344 | Values: 772.2 08:25:47 INFO - PROCESS | 7344 | 08:25:47 INFO - PROCESS | 7344 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 08:25:47 INFO - PROCESS | 7344 | Values: 12345.7 08:25:47 INFO - PROCESS | 7344 | 08:25:47 INFO - PROCESS | 7344 | [#7] RegExp Cycles:1 Average:41224.49 Median:41224.49 stddev:0.00 (0.0%) 08:25:47 INFO - PROCESS | 7344 | Values: 41224.5 08:25:47 INFO - PROCESS | 7344 | 08:25:47 INFO - PROCESS | 7344 | [#8] Splay Cycles:1 Average:632.91 Median:632.91 stddev:0.00 (0.0%) 08:25:47 INFO - PROCESS | 7344 | Values: 632.9 08:25:47 INFO - PROCESS | 7344 | 08:25:47 INFO - PROCESS | 7344 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 08:25:47 INFO - PROCESS | 7344 | Values: 4854.4 08:25:47 INFO - PROCESS | 7344 | -------- Summary: end -------- 08:25:47 INFO - PROCESS | 7344 | 08:25:48 INFO - TEST-INFO | 7344: exit 0 08:25:48 INFO - TEST-OK | v8_7 | took 40690ms 08:25:48 INFO - SUITE-END | took 1212s 08:25:48 INFO - Completed test suite (00:20:12) 08:25:48 INFO - Working with test: dromaeo_css 08:25:48 INFO - Generating results file: dromaeo_css 08:25:48 INFO - Working with test: kraken 08:25:48 INFO - Generating results file: kraken 08:25:48 INFO - javascript benchmark 08:25:48 INFO - Working with test: v8_7 08:25:48 INFO - Generating results file: v8_7 08:25:48 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:25:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 08:25:48 INFO - process_Request line: dromaeo_css 6573.48 graph.html#tests=[[72,201,35]] 08:25:48 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:25:48 INFO - process_Request line: kraken 1497.70 graph.html#tests=[[232,201,35]] 08:25:48 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:25:48 INFO - process_Request line: v8_7 18867.28 graph.html#tests=[[230,201,35]] 08:25:48 INFO - RETURN: dromaeo_css: 6573.48 08:25:48 INFO - RETURN: kraken: 1497.70 08:25:48 INFO - RETURN: v8_7: 18867.28 08:25:48 INFO - javascript benchmark 08:25:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3063.7395821355185, 3066.75465962723, 3115.532670099486, 3117.4700300948834, 3139.152428844213, 4979.053979743846, 5008.749562521877, 5017.924731129031, 5038.345015148035, 5059.822906198279, 4960.6031517478605, 4972.7762250698715, 5018.222175562784, 5022.447530771612, 5045.77294021769, 4540.90918181637, 4581.839635612754, 4613.100445413146, 4634.814607415699, 4688.5077066908, 4693.6949098308505, 4726.149293127236, 4735.076660051292, 4744.596709279698, 4744.928826067612, 4519.367288579601, 4520.095980803836, 4572.017016341502, 4591.4260717410325, 4608.423947006624, 4551.658625603093, 4558.931616025729, 4560.543945605413, 4581.427321584802, 4610.792514336863, 4522.932156017662, 4534.229181039198, 4535.63714902807, 4536.02475467776, 4589.931151032737, 4776.259679749644, 4838.104950584118, 4908.754562271908, 4972.651914365996, 4973.776180071905, 5286.920696189561, 5304.946950530522, 5316.840494785162, 5323.733813309319, 5331.1470164773455, 5355.544778693816, 5355.544778693816, 5365.0, 5405.108157154064, 5426.131818908995, 5063.291139240509, 5089.974550127263, 5092.9236061459105, 5164.483551644843, 5180.0157969985585, 5529.474699903502, 5529.917051244234, 5532.28080349552, 5535.972320138373, 5582.27430434041, 5330.946690533045, 5334.839954801285, 5335.733213339317, 5336.626436149432, 5337.86655333612, 5289.206619007103, 5354.705491198021, 5378.11261141915, 5441.047816632153, 5482.205080263339, 5416.160495123262, 5445.128779395278, 5452.727363631802, 5455.181722741541, 5457.399686034533, 5252.842414727565, 5400.91898621521, 5428.321459817523, 5455.318085239345, 5502.779888804483, 4194.2869712148395, 4220.704550681484, 4226.049138943713, 4233.97883010583, 4240.872773816791, 3808.638179372955, 3820.2359528094494, 3820.3887378019385, 3850.6919446444217, 3850.7497012694644, 5050.621203409685, 5056.342675452168, 5062.240663900371, 5063.11395505785, 5097.8725531862, 5346.893062138735, 5369.27514785499, 5391.865203369869, 5417.729113544307, 5434.076207044812, 4973.925391119136, 5008.799648014038, 5008.924866127011, 5010.3737032870895, 5053.84838454847, 4590.081983603292, 4648.581627653527, 4649.023705021983, 4662.603678687349, 4679.67242293043, 5356.544693701079, 5460.808871689551, 5482.424345443751, 5498.8075417361, 5547.057000309957, 5350.5184533392185, 5359.356877174764, 5360.973195133999, 5374.623776335619, 5380.273663055594, 5501.587380946525, 5526.585506086979, 5531.170324451365, 5554.611177217556, 5575.330960284792, 5298.046351656584, 5301.973490132525, 5319.893602128013, 5321.042212401805, 5371.946280537145, 5389.461053894579, 5423.3491980962535, 5432.239486471976, 5435.718302009826, 5481.75332110048, 5129.076766182123, 5154.458781827854, 5160.071187186342, 5299.973500132474, 5309.946900531099, 5268.894622107613, 5280.551153151871, 5284.550813180923, 5292.444293349143, 5316.096263635269, 5195.506426889439, 5197.312764369246, 5199.92200116991, 5208.401033881, 5235.476452354734, 5250.474952504719, 5270.8155214567305, 5315.069862774077, 5325.2810870531985, 5327.6803391795065, 5249.055170069424, 5249.527542521191, 5250.212468129811, 5255.579553635776, 5267.78928842842], "unit": "score", "name": "dojo.html", "value": 4983.640493850398}, {"lowerIsBetter": false, "replicates": [536.9301990741203, 537.74188389573, 558.9832305030848, 563.3633993587247, 585.2012003615067, 27471.725282747168, 27920.72079279209, 34298.485522717114, 34877.65122348776, 34976.650233497654, 37635.0, 38088.42867356985, 38145.0, 38159.618403815955, 38160.0, 8144.4298899077085, 8352.498850068985, 8355.749327520154, 8356.080831108573, 8356.791080222982, 8321.375896807733, 8415.537145457029, 8447.493150410965, 8462.74611761645, 8471.0, 8396.202360775716, 8453.788655283637, 8472.15278472154, 8472.364572657045, 8486.405951583392, 8260.380471464634, 8412.1587841216, 8412.453190542656, 8418.074011858691, 8440.198181172778, 8247.340212782963, 8331.33349332052, 8351.24838764514, 8354.665813367457, 8360.874586881202, 36712.082197945, 37235.0, 37452.62547374519, 37470.06324841874, 37489.43765843515, 2965.4513914925806, 3047.9390412191856, 3059.143439836849, 3065.2949821540947, 3194.34515924235, 28124.437511249864, 28828.567571486445, 29062.0, 29083.41833163346, 29288.121356359345, 3478.2521757821937, 3492.406290930548, 3602.3875941089814, 3694.131879008431, 3695.815209239527, 249677.0, 249684.0, 249980.0, 250046.0, 250332.0, 48925.266121008215, 49598.75200624046, 53258.73370633122, 53419.0, 53619.0, 57520.4247957515, 59333.40666593365, 59474.0, 59589.70205148947, 59675.701621491615, 13460.93269533646, 13465.932670336586, 13547.932260338635, 13554.322283885766, 13562.321883905764, 9274.814503709888, 9569.760755981157, 9718.368306060083, 9818.90181098194, 10851.728706782395, 17832.286708531512, 17954.0, 18095.095245237684, 18104.185311661007, 18133.727994080098, 7168.92831071693, 7508.324250817453, 7561.735339263099, 7581.12817026038, 7596.24037596247, 917.7934964632905, 951.219999600335, 974.3179774158118, 1063.5586231713753, 1145.8109411947103, 24044.27867163988, 25287.241382758548, 26398.41609503436, 26657.73342266591, 26840.194794156207, 1008.4302369161401, 1017.7862648843677, 1027.7071034755058, 1070.71626019105, 1093.2292733622776, 12903.870961290268, 13284.667883302995, 13655.863441365658, 13775.242361670003, 13775.586732398044, 312152.0, 313252.0, 314859.0, 315099.0, 315905.0, 49842.75078624584, 50104.24843627348, 50218.748906255234, 50265.24602130971, 50309.0, 1345.2869978911192, 1356.3015047250674, 1372.0601388049217, 1374.924379159156, 1379.379279324308, 24117.397065073514, 25579.744202557737, 26081.608775867997, 26169.0, 26186.607200892384, 41697.16605667809, 41790.79104604458, 42093.0, 42132.57867421409, 42138.57861421347, 267464.0, 271139.0, 289881.0, 293144.0, 363888.0, 29229.707702923548, 29306.7069329304, 29486.852565737034, 29606.555901661923, 29888.402231954806, 40825.38761918633, 40996.79501602473, 41480.0, 42251.57748422599, 42475.3628695576, 34329.48505772366, 34790.0, 34833.0, 35138.824305878305, 35808.0, 31784.841075794473, 31967.0, 32260.0, 32336.83831580827, 32702.34595308128, 31608.36783264368, 32097.358052838346, 32376.05743655388, 32377.190570235933, 32389.19027024343, 27893.302667433476, 28798.424031519673, 30990.535141973338, 31747.20631984219, 31943.68056319407, 23106.653400199346, 23405.76594234036, 23408.53182936366, 24235.412625353238, 24591.50816983686], "unit": "score", "name": "ext.html", "value": 17297.63468671485}, {"lowerIsBetter": false, "replicates": [350.40256362901255, 354.81549594211026, 357.97852128872256, 364.2569158915812, 367.49285985340225, 13529.932350338235, 13706.355237371505, 15579.922100389496, 16542.586435339123, 17830.375936842214, 14633.92683036586, 15682.529524114267, 15864.0, 15971.600709982256, 16733.414330498406, 5321.813736519213, 5528.226048353234, 5531.308586426697, 5531.529819965308, 5532.529734972532, 4006.83972641094, 4131.194417088669, 5393.7572809223675, 5471.23402723619, 5762.423757624246, 5695.971520142393, 5904.261967254093, 5957.910631340512, 5964.493018093467, 5978.641281523101, 5981.9700901495435, 6052.425019623129, 6060.636361818283, 6064.666443345636, 6068.878622427526, 5082.110630639623, 5230.372355317349, 5232.0, 5243.0, 5252.763625636855, 19696.80303196964, 19826.504337391536, 19973.600527989503, 19977.30079447227, 20122.29571964974, 2054.0756659503136, 2149.12960251097, 2159.9028043737912, 2387.6418537219383, 2754.0, 12655.367231638382, 12703.428345724464, 12860.485580576766, 12999.545015924397, 13132.0, 1800.3518733256017, 1802.152988095593, 1839.4205825165163, 1843.6404901044302, 1855.3877220517331, 37108.44337334942, 52982.47017529853, 54607.72696136533, 54913.450865491635, 56079.15881261785, 9028.232600228923, 9225.0, 9225.953870230605, 9250.629974801068, 9261.073892610684, 11854.94072529632, 11871.347075910908, 11878.940605296919, 11892.643220703392, 11905.583304584472, 6859.862802743917, 6872.312768723088, 7002.40479559233, 7055.541389809646, 7128.322809333209, 6835.350641689031, 6889.414399775975, 6892.310768923167, 6921.826954326182, 6927.134108236471, 3975.185087057146, 3975.588666023578, 3980.5223373195404, 3990.0, 4003.619656132721, 1615.3215649427268, 1616.3938523053855, 1651.4880387079804, 1704.514213449161, 1754.2807448946126, 382.9655331020166, 894.1594900793234, 913.9131782480654, 970.2819913264134, 984.867042949207, 9321.207697345802, 9566.378185417925, 9662.855057174149, 9682.225421966366, 9849.901500985041, 397.2928187825675, 403.7557277846919, 404.3954288338952, 410.05073255413623, 416.7624454061217, 5406.162044883049, 5428.972855135699, 5433.130699088127, 5483.958047970873, 5513.145462453326, 482642.0, 493779.0, 495582.0, 508786.0, 514184.0, 53366.466335336925, 61723.89516624374, 62036.37963620306, 65460.01809972854, 66132.0, 1113.8886111388958, 1142.6343570057668, 1150.6605551362536, 1159.2175281684829, 1159.8028335182871, 15096.24518774079, 15252.923735381251, 15374.846251537341, 15410.614734631725, 15609.141497217308, 32952.0, 33446.49830252597, 33569.66430335665, 33823.15442113967, 33998.66001340054, 35886.461703074994, 40762.0, 41480.0, 42103.36844947389, 42467.5753242476, 7070.515191809777, 7251.891221631785, 7287.161976372785, 7321.816954575965, 7392.112946446246, 9191.494467804068, 10392.844107338246, 10704.571817127227, 10724.356538607708, 11086.22396432242, 8147.388945829205, 8513.95743021281, 8639.827203456021, 8824.735257942271, 9100.681476148304, 8522.0, 9145.451272923647, 9354.111359420844, 9442.291828113057, 9708.75728106803, 3619.5475565554307, 8141.877871831809, 8221.424500284922, 8310.792230194293, 8528.658853645784, 7125.144982601913, 7299.5620262784405, 7368.37368823656, 7370.189279179179, 7372.96313518429, 8460.153984601491, 8728.738137855875, 8751.474911505331, 8836.91163088361, 8840.823183536422], "unit": "score", "name": "jquery.html", "value": 7499.464728024049}, {"lowerIsBetter": false, "replicates": [1323.9073264871463, 1435.6554426937535, 1454.5054681408321, 1592.1720705233279, 1778.084286592405, 7089.32651398117, 7635.083789945207, 7811.023622047244, 7817.687292508307, 7818.609069546515, 7594.316511513963, 7736.7678969631, 7767.456278060524, 7768.0, 7790.688372465094, 2003.1086166655843, 2058.135583055113, 2058.6809044598112, 2339.087755775249, 2365.6333268343433, 2072.253988564116, 2290.2098775922364, 2325.383773300077, 2337.345543247885, 2339.9649005264932, 2298.816094712419, 2318.9420264493356, 2329.9184528541505, 2330.650402439631, 2358.351453350334, 2205.106931692651, 2229.2532001779423, 2230.431240033789, 2235.2065016918923, 2243.461569223391, 2283.817294616427, 2285.7028586283677, 2286.9085236590518, 2287.1194590082773, 2311.872846993415, 7959.204079591995, 8021.438499305051, 8027.076886158108, 8027.397945154137, 8030.959845200737, 4797.95202047982, 4915.434725006634, 4930.4330002049865, 4935.35840340757, 4935.605151587864, 2948.071357522395, 2998.925026874324, 3018.5623084652602, 3022.2595464111214, 3024.6389124893667, 919.3334832246568, 922.5710044829186, 923.1783712495884, 969.4328817641688, 1008.6873069348452, 11173.21787474877, 11283.435828208556, 11296.039836613898, 11320.150988675883, 11322.32066076038, 4430.269005614102, 4512.3908272382805, 4538.478075021349, 4574.153781550423, 4583.816647334069, 9325.580348884316, 9341.439513629204, 9391.389559678599, 9397.953010234905, 9416.811663766686, 4925.950740492621, 4969.055879382906, 4969.726665033458, 4971.37857767779, 4972.7513624318635, 4478.417805685305, 4515.0969806038265, 4522.3668686383935, 4525.298578720303, 4526.388937493462, 3429.1427143214196, 3526.1360966563357, 3680.4479328100465, 3799.1072098056934, 3829.0, 1203.3983008495752, 1206.149664486535, 1212.1151559361715, 1215.0461887418335, 1218.8781121887741, 1188.5305304404712, 1226.1600803449664, 1231.310466138965, 1236.6290112966074, 1237.2514628649537, 7145.178304494945, 7156.248593897566, 7260.818479537948, 7279.41764658826, 7280.890786638205, 1097.0620119797618, 1097.5664612478026, 1100.6940459736838, 1102.9779404412027, 1118.4854966715402, 5775.0, 5841.474267315877, 5869.236999190078, 5879.235699359056, 5880.0297950838485, 9530.856297244374, 9695.22438204956, 9941.055599718014, 9957.950210248902, 9962.551685174185, 9643.566039528238, 9656.613735450503, 9742.75643108928, 9768.560414781352, 9781.119699226962, 7205.963970180115, 7414.8887766682465, 7425.480216384801, 7443.36731377839, 7536.0956685198125, 7134.607596582237, 7203.927960720326, 7211.891821622575, 7213.531120477152, 7220.133583969957, 8125.553094579855, 8338.124496927736, 8527.74416767498, 8533.871991920001, 8547.700830470903, 8483.703070392507, 8531.488110713377, 8555.31557475388, 8559.61481733336, 8751.824963500567, 6714.899276510759, 6794.082798822095, 6802.421794147355, 6816.182058153054, 6817.181938167451, 6730.528862979741, 6848.623325716934, 7439.776806695808, 7507.549547027196, 7510.812229694083, 6650.900236496554, 6686.498512611476, 6711.362420570234, 6738.898916516354, 6835.521513494206, 6661.533692641662, 6709.630970296485, 6717.227518835396, 6818.488613354118, 6910.447164226749, 6817.079694241214, 6823.590584564942, 6837.794866154023, 6879.6560171992205, 6881.965590172217, 6333.96833015832, 6369.617822930639, 6373.267074286331, 6475.514336424692, 6527.0, 6480.481561475165, 6594.571352862241, 6616.470682345497, 6625.138731964814, 6631.33686631333], "unit": "score", "name": "mootools.html", "value": 4517.152099468133}, {"lowerIsBetter": false, "replicates": [343.5722525455808, 350.7054074577355, 351.08016995471866, 351.9894403167906, 353.91682954505694, 5830.067189249721, 5863.149843272723, 5877.529797616191, 5905.143754155645, 5918.260217472816, 5523.502884740373, 5591.692456914868, 5673.943260567393, 5772.163036359725, 5798.478136967672, 4449.888752781174, 4465.910681786362, 4480.395146655209, 4485.327200919855, 4485.887852803673, 4299.935500967488, 4462.12988467249, 4468.352088947101, 4472.955270447303, 4480.0, 4311.655067594585, 4368.25739624263, 4413.514513403523, 4430.734155950637, 4436.800343984512, 4416.536263692315, 4428.7121337112985, 4429.822807087713, 4436.401085853401, 4437.0682156747125, 3890.961090389088, 3892.104815892332, 3898.4542164097047, 3899.8245078971513, 3907.609239076098, 5414.214938833887, 5532.861678458071, 5538.972305138489, 5540.722963851832, 5544.641562817135, 5161.27742116104, 5222.529972302473, 5240.711760853152, 5245.947540524584, 5252.553532949704, 6125.234345706786, 6134.693265336716, 6135.570510064297, 6139.447449729501, 6144.201253836973, 4419.049904270565, 4425.3140763181755, 4430.202563538562, 4432.913936085647, 4435.600795928382, 6309.310842083873, 6337.429631333156, 6406.871862562769, 6410.0, 6419.0, 4421.093675796454, 4448.1770872388715, 4451.888702782391, 4453.131639330364, 4455.665825063068, 4493.865184044418, 4494.37078808967, 4513.593776560126, 4517.41273634432, 4523.457185137739, 5168.638195326291, 5173.586113110942, 5177.456367081478, 5178.404483484447, 5184.326037615086, 6038.245219347582, 6194.721237544321, 6195.256569211723, 6201.937980620136, 6202.317745048041, 1603.791507104069, 1641.1137985487942, 1641.4829328761402, 1641.5239580521754, 1642.0476123848377, 1069.946502674863, 1086.7717779266284, 1087.950128126362, 1089.1178145702006, 1106.3417266726285, 5896.115582662549, 5897.2038774765715, 5898.4101589840675, 5898.997170481029, 5906.704664766745, 6319.115323854664, 6338.683065846689, 6341.460975817107, 6346.809595712136, 6351.333110023474, 5676.858078548069, 5767.250257466502, 5787.826365209051, 5871.3541510433815, 5888.440598143169, 3405.1146701857697, 3418.3846907556876, 3433.53647257617, 3442.294329662413, 3443.4318337474037, 6577.158395649226, 6582.539222254492, 6591.0, 6599.142111525471, 6600.8349791255605, 6395.104685344056, 6520.641364724891, 6572.835679107965, 6573.276939536647, 6575.835604109936, 6605.438537724252, 6610.305917878553, 6610.8347291318105, 6613.933860661332, 6614.470842332602, 6406.327335629878, 6407.1350367701625, 6410.61536307823, 6414.069959855701, 6416.647084410402, 6122.877542449037, 6349.841253968688, 6376.362363763772, 6378.2346118466085, 6379.234491861006, 6619.27188009309, 6621.205455345389, 6622.238442579165, 6622.84100282439, 6627.502937279627, 4437.090396468651, 4456.197884380843, 4469.709468884512, 4479.148961697267, 4479.372887795646, 6225.28409232944, 6371.49028077762, 6385.265694445013, 6386.840328991812, 6387.968060159669, 6183.5671502994355, 6233.563650544418, 6238.064290356483, 6239.126522286792, 6242.250929888442, 6223.253209614875, 6230.719617617127, 6243.500519958483, 6253.155823963707, 6255.593386429868, 5948.910766338422, 6120.296165940974, 6132.38676132401, 6144.078388241799, 6155.569110162246, 6265.749370025148, 6271.4669253114, 6274.46667033289, 6285.717142728497, 6285.905711414424, 6122.571420000557, 6134.478569321657, 6139.815805525842, 6139.938600613937, 6143.631382117087], "unit": "score", "name": "prototype.html", "value": 4691.602385465279}, {"lowerIsBetter": false, "replicates": [691.4986634689849, 760.1220590218296, 763.7823220382193, 765.3915137465714, 765.506248469737, 11403.714907127325, 11484.196106272544, 11520.481578328974, 11525.19323647345, 11541.422928853555, 12091.153619246656, 14555.781663275033, 14794.778078328834, 14794.852051479482, 14811.259437028133, 648.7923864363405, 656.8751937131954, 761.7105499910026, 766.3371183925906, 782.6126067596548, 772.5596410046276, 777.6539439949197, 778.1168373895641, 780.894579231805, 781.3007358414216, 807.5921659561913, 810.1695761844128, 810.5096416667919, 811.2495941254346, 811.4117264982899, 667.6795138333579, 677.5629718831351, 799.9600019999006, 811.5942028985507, 813.5322189740923, 593.1399470767404, 596.8627215740361, 601.3205078261581, 601.4076135007015, 601.6600620649319, 13524.729505409836, 13582.25297608631, 13591.728165436636, 13595.184288942695, 13646.181229126285, 10765.300255483447, 10958.123350131971, 11088.168387370979, 11148.944255278753, 11469.0, 9467.774534022048, 9854.704358869174, 9986.151177149952, 9992.750181245454, 10017.549210285555, 2841.176058942904, 2887.364779748452, 2904.6223990881263, 2917.7374036336832, 2923.1961210667023, 45398.77300613476, 45412.772936135436, 45521.0, 46010.76994615039, 46016.30975535369, 9228.169464748205, 9269.258459323239, 9294.0, 9369.812603747887, 9411.4823684698, 16963.0, 16966.066866322224, 16974.915125424293, 17012.234449449803, 17051.91474042622, 7180.0, 7186.317299856505, 7414.555126692416, 7522.736704215326, 7554.508956917783, 4128.4632997710105, 4232.32282834745, 4349.108432771274, 4366.956330436655, 4503.617192538671, 2871.1530098620956, 2917.9124626261246, 2929.487339715541, 2931.9120426387244, 2937.3390987028174, 549.2557584472981, 556.2573963758347, 565.135342925325, 569.8774763425884, 569.9287589051369, 576.1559315602663, 583.4428121144297, 598.1267349669445, 626.7179769103922, 637.4772686397109, 8461.238488535939, 8783.868241976375, 8800.16398442147, 8894.0, 9024.458532488072, 528.8307741522752, 617.4658920034228, 635.6630985577559, 641.416311156845, 647.7311915555086, 3680.4663323817895, 3700.8519659213866, 3959.2675355059405, 3993.84024639017, 4086.8160932758096, 53530.0, 53627.19559206615, 54126.72936635291, 54212.72893635585, 54355.0, 49256.50743492591, 49485.75257123763, 49993.0, 50227.24659130116, 50382.748086260064, 42889.78555107205, 42896.571034289256, 43197.35203971943, 43749.78125109354, 44230.77884610621, 7976.441649084509, 8209.09699932995, 8242.917570824455, 8266.966629171353, 8291.295239904675, 33042.33915321632, 33581.160470987445, 33715.3256934855, 33719.0, 34347.0, 39296.607033930435, 41917.0, 42543.7872810634, 42860.0, 43036.0, 9129.589168487566, 9410.38832475887, 9470.337076404585, 9503.66737164196, 9548.37935534188, 10340.844887326846, 10361.63734269297, 10463.372197668165, 10480.895191047992, 10771.515281812493, 9927.702168934944, 10393.116585090353, 10442.321249118782, 10717.678469645924, 10774.838377424188, 9942.552585133542, 10086.646967356108, 10187.0, 10192.898071019492, 10276.39689799147, 9281.257499400166, 9418.993582914254, 9601.47191904452, 9662.71011869617, 9844.409335439897, 8446.239838414573, 8570.749296667502, 8628.180322869317, 8926.107389261022, 8962.0, 8212.425130240827, 8455.32357411418, 8497.192766687154, 8643.135686431306, 8729.0], "unit": "score", "name": "yui.html", "value": 5888.25789051473}], "name": "dromaeo_css", "value": 6573.48142999248}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 104.0, 109.0, 110.0, 110.0, 109.0, 109.0, 104.0, 108.0], "unit": "score", "name": "ai-astar", "value": 108.3}, {"lowerIsBetter": true, "replicates": [160.0, 127.0, 167.0, 160.0, 125.0, 151.0, 148.0, 135.0, 170.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [159.0, 161.0, 160.0, 160.0, 160.0, 161.0, 163.0, 160.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [75.0, 83.0, 127.0, 93.0, 72.0, 73.0, 73.0, 109.0, 108.0, 75.0], "unit": "score", "name": "audio-fft", "value": 88.8}, {"lowerIsBetter": true, "replicates": [97.0, 95.0, 157.0, 96.0, 95.0, 95.0, 140.0, 99.0, 95.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 111.0}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 144.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 144.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 55.0, 56.0, 56.0, 55.0, 54.0, 55.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 69.0, 67.0, 70.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 82.0, 82.0, 82.0, 84.0, 84.0, 84.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [115.0, 116.0, 126.0, 118.0, 118.0, 115.0, 123.0, 112.0, 112.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.0}, {"lowerIsBetter": true, "replicates": [142.0, 149.0, 144.0, 139.0, 136.0, 131.0, 139.0, 152.0, 144.0, 150.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.6}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 67.0, 70.0, 65.0, 67.0, 65.0, 66.0, 68.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1497.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.47613465081227], "unit": "score", "name": "Richards", "value": 210.7882419999999}, {"lowerIsBetter": false, "replicates": [189.82536066818528], "unit": "score", "name": "DeltaBlue", "value": 348.30962399999987}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1964.6365422396857], "unit": "score", "name": "RayTrace", "value": 376.654401}, {"lowerIsBetter": false, "replicates": [772.2007722007722], "unit": "score", "name": "Earley", "value": 863.0695849999998}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [41224.489795918365], "unit": "score", "name": "RegExp", "value": 22.098150990099022}, {"lowerIsBetter": false, "replicates": [632.9113924050633], "unit": "score", "name": "Splay", "value": 128.75577999999996}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 18867.2771512325}]} 08:25:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "18867.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1497.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6573.48"}}} 08:25:48 INFO - Return code: 0 08:25:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 08:25:48 INFO - # TBPL SUCCESS # 08:25:48 INFO - Running post-action listener: _resource_record_post_action 08:25:48 INFO - Running post-run listener: _resource_record_post_run 08:25:49 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 114688; Write bytes: 556961792; Read time: 444; Write time: 486360 08:25:49 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 12288; Write bytes: 247943168; Read time: 216; Write time: 250632 08:25:49 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 102400; Write bytes: 309018624; Read time: 228; Write time: 235728 08:25:49 INFO - Running post-run listener: _upload_blobber_files 08:25:49 INFO - Blob upload gear active. 08:25:49 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 08:25:49 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:25:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 08:25:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 08:25:50 INFO - (blobuploader) - INFO - Open directory for files ... 08:25:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:25:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:25:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:51 INFO - (blobuploader) - INFO - Done attempting. 08:25:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 08:25:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:25:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:25:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:25:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:25:52 INFO - (blobuploader) - INFO - Done attempting. 08:25:52 INFO - (blobuploader) - INFO - Iteration through files over. 08:25:52 INFO - Return code: 0 08:25:52 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 08:25:52 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 08:25:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1511d151d5f433b6ea3be8332015b001da5e32d1316fd02b18849023946c9b04d5d6bce8042e01f1beb4c9292be8128155fd000d47315ba46deb53a7c0918896", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/41952ac13a0117dd9df3cdbcd616fa1d9921af1ede9884a5469e731f1ada7055a5b09b4b75347c1f580d9259ef55540b7fb47540e3a81354fa6227ada7018b94"} 08:25:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 08:25:52 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 08:25:52 INFO - Contents: 08:25:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1511d151d5f433b6ea3be8332015b001da5e32d1316fd02b18849023946c9b04d5d6bce8042e01f1beb4c9292be8128155fd000d47315ba46deb53a7c0918896", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/41952ac13a0117dd9df3cdbcd616fa1d9921af1ede9884a5469e731f1ada7055a5b09b4b75347c1f580d9259ef55540b7fb47540e3a81354fa6227ada7018b94"} 08:25:52 INFO - Running post-run listener: copy_logs_to_upload_dir 08:25:52 INFO - Copying logs to upload dir... 08:25:52 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 08:25:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.504433 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-25 08:25:51.898399) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 08:25:51.901930) ========= 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=aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1511d151d5f433b6ea3be8332015b001da5e32d1316fd02b18849023946c9b04d5d6bce8042e01f1beb4c9292be8128155fd000d47315ba46deb53a7c0918896", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/41952ac13a0117dd9df3cdbcd616fa1d9921af1ede9884a5469e731f1ada7055a5b09b4b75347c1f580d9259ef55540b7fb47540e3a81354fa6227ada7018b94"} build_url:https://queue.taskcluster.net/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011147 build_url: 'https://queue.taskcluster.net/v1/task/TJqe7uPCTcu6iFZKIr_L0Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/1511d151d5f433b6ea3be8332015b001da5e32d1316fd02b18849023946c9b04d5d6bce8042e01f1beb4c9292be8128155fd000d47315ba46deb53a7c0918896", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/41952ac13a0117dd9df3cdbcd616fa1d9921af1ede9884a5469e731f1ada7055a5b09b4b75347c1f580d9259ef55540b7fb47540e3a81354fa6227ada7018b94"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 08:25:51.929388) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:25:51.929911) ========= 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=aa08bb06ff6271ef470a76a4000001be-1453737750.903554-355692002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 08:25:52.014288) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 08:25:52.014634) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 08:25:52.014945) ========= ========= Total master_lag: 0.52 =========