builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-026 starttime: 1457992624.71 results: success (0) buildid: 20160314120416 builduid: 68fbc588cd194569a71c51b6d1cd9758 revision: b31b7bd99b5f4f0f5ce37fc807e2cf3f2f987cf1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:04.712351) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:04.715442) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:04.715799) ========= 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=41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004711 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:04.777691) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:04.778017) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:04.880741) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:04.881038) ========= 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=41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.035387 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:04.932271) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:04.932606) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:04.933008) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:04.933352) ========= 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=41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-14 14:57:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 115M=0s 2016-03-14 14:57:05 (115 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.267089 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:05.211596) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:05.211921) ========= 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=41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.062126 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:05.289388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:05.289760) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b31b7bd99b5f4f0f5ce37fc807e2cf3f2f987cf1 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b31b7bd99b5f4f0f5ce37fc807e2cf3f2f987cf1 --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=41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-14 14:57:05,421 truncating revision to first 12 chars 2016-03-14 14:57:05,421 Setting DEBUG logging. 2016-03-14 14:57:05,421 attempt 1/10 2016-03-14 14:57:05,421 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b31b7bd99b5f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 14:57:05,692 unpacking tar archive at: mozilla-beta-b31b7bd99b5f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.616879 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:05.922073) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:05.922497) ========= echo b31b7bd99b5f4f0f5ce37fc807e2cf3f2f987cf1 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b31b7bd99b5f4f0f5ce37fc807e2cf3f2f987cf1'] 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=41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b31b7bd99b5f4f0f5ce37fc807e2cf3f2f987cf1 program finished with exit code 0 elapsedTime=0.003951 script_repo_revision: 'b31b7bd99b5f4f0f5ce37fc807e2cf3f2f987cf1' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:05.972162) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:05.972513) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 14:57:05.982536) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-03-14 14:57:05.982865) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:57:06 INFO - MultiFileLogger online at 20160314 14:57:06 in /builds/slave/test-pgo 14:57:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:57:06 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:57:06 INFO - {'append_to_log': False, 14:57:06 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:57:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:57:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:57:06 INFO - 'branch': 'Mozilla-Beta', 14:57:06 INFO - 'buildbot_json_path': 'buildprops.json', 14:57:06 INFO - 'config_files': ('talos/linux_config.py',), 14:57:06 INFO - 'default_actions': ('clobber', 14:57:06 INFO - 'read-buildbot-config', 14:57:06 INFO - 'download-and-extract', 14:57:06 INFO - 'populate-webroot', 14:57:06 INFO - 'create-virtualenv', 14:57:06 INFO - 'install', 14:57:06 INFO - 'run-tests'), 14:57:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:57:06 INFO - 'download_minidump_stackwalk': True, 14:57:06 INFO - 'download_symbols': 'ondemand', 14:57:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:57:06 INFO - 'tooltool.py': '/tools/tooltool.py', 14:57:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:57:06 INFO - '/tools/misc-python/virtualenv.py')}, 14:57:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:57:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:57:06 INFO - 'installer_path': 'installer.exe', 14:57:06 INFO - 'log_level': 'info', 14:57:06 INFO - 'log_name': 'talos', 14:57:06 INFO - 'log_to_console': True, 14:57:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:57:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:57:06 INFO - 'opt_config_files': (), 14:57:06 INFO - 'pip_index': False, 14:57:06 INFO - 'sps_profile': False, 14:57:06 INFO - 'sps_profile_interval': 0, 14:57:06 INFO - 'suite': 'dromaeojs', 14:57:06 INFO - 'system_bits': '32', 14:57:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:57:06 INFO - 'title': 'talos-linux64-ix-026', 14:57:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:57:06 INFO - 'use_talos_json': True, 14:57:06 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:57:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:57:06 INFO - 'work_dir': 'build'} 14:57:06 INFO - ##### 14:57:06 INFO - ##### Running clobber step. 14:57:06 INFO - ##### 14:57:06 INFO - Running pre-action listener: _resource_record_pre_action 14:57:06 INFO - Running main action method: clobber 14:57:06 INFO - rmtree: /builds/slave/test-pgo/build 14:57:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:57:11 INFO - Running post-action listener: _resource_record_post_action 14:57:11 INFO - ##### 14:57:11 INFO - ##### Running read-buildbot-config step. 14:57:11 INFO - ##### 14:57:11 INFO - Running pre-action listener: _resource_record_pre_action 14:57:11 INFO - Running main action method: read_buildbot_config 14:57:11 INFO - Using buildbot properties: 14:57:11 INFO - { 14:57:11 INFO - "project": "", 14:57:11 INFO - "product": "firefox", 14:57:11 INFO - "script_repo_revision": "production", 14:57:11 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:57:11 INFO - "repository": "", 14:57:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:57:11 INFO - "buildid": "20160314120416", 14:57:11 INFO - "pgo_build": "True", 14:57:11 INFO - "basedir": "/builds/slave/test-pgo", 14:57:11 INFO - "buildnumber": 124, 14:57:11 INFO - "slavename": "talos-linux64-ix-026", 14:57:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:57:11 INFO - "platform": "ubuntu64_hw", 14:57:11 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:57:11 INFO - "branch": "mozilla-beta", 14:57:11 INFO - "repo_path": "releases/mozilla-beta", 14:57:11 INFO - "revision": "b31b7bd99b5f4f0f5ce37fc807e2cf3f2f987cf1", 14:57:11 INFO - "stage_platform": "linux64-pgo", 14:57:11 INFO - "builduid": "68fbc588cd194569a71c51b6d1cd9758", 14:57:11 INFO - "slavebuilddir": "test" 14:57:11 INFO - } 14:57:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 14:57:11 INFO - Running post-action listener: _resource_record_post_action 14:57:11 INFO - ##### 14:57:11 INFO - ##### Running download-and-extract step. 14:57:11 INFO - ##### 14:57:11 INFO - Running pre-action listener: _resource_record_pre_action 14:57:11 INFO - Running main action method: download_and_extract 14:57:11 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:11 INFO - https://queue.taskcluster.net/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:57:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/test_packages.json 14:57:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/test_packages.json 14:57:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:57:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:57:15 INFO - Downloaded 1412 bytes. 14:57:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:57:15 INFO - Using the following test package requirements: 14:57:15 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 14:57:15 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 14:57:15 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:57:15 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 14:57:15 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 14:57:15 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 14:57:15 INFO - u'jsshell-linux-x86_64.zip'], 14:57:15 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 14:57:15 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:57:15 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 14:57:15 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 14:57:15 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 14:57:15 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 14:57:15 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 14:57:15 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 14:57:15 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:57:15 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 14:57:15 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 14:57:15 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:57:15 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:57: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')]} 14:57:15 INFO - https://queue.taskcluster.net/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:57:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 14:57:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 14:57:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 14:57:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:57:19 INFO - Downloaded 23104293 bytes. 14:57:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:57:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 14:57:21 INFO - Return code: 0 14:57:21 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:57:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:21 INFO - https://queue.taskcluster.net/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:57:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 14:57:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 14:57:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 14:57:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:57:24 INFO - Downloaded 23104293 bytes. 14:57:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:57:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 14:57:26 INFO - Return code: 0 14:57:26 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')]} 14:57:26 INFO - https://queue.taskcluster.net/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:57:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 14:57:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 14:57:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 14:57:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:57:27 INFO - Downloaded 10801536 bytes. 14:57:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 14:57:27 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 14:57:27 INFO - Return code: 0 14:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:27 INFO - https://queue.taskcluster.net/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:57:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 14:57:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 14:57:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 14:57:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:57:29 INFO - Downloaded 52853097 bytes. 14:57:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 14:57:29 INFO - mkdir: /builds/slave/test-pgo/properties 14:57:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:57:29 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:57:29 INFO - Contents: 14:57:29 INFO - build_url:https://queue.taskcluster.net/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 14:57:29 INFO - Running post-action listener: _resource_record_post_action 14:57:29 INFO - Running post-action listener: set_extra_try_arguments 14:57:29 INFO - ##### 14:57:29 INFO - ##### Running populate-webroot step. 14:57:29 INFO - ##### 14:57:29 INFO - Running pre-action listener: _resource_record_pre_action 14:57:29 INFO - Running main action method: populate_webroot 14:57:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:57:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:57:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:57:29 INFO - '--tppagecycles', 14:57:29 INFO - '7'], 14:57:29 INFO - 'tests': ['tsvgm']}}, 14:57:29 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:57:29 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:57:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:57:29 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:57:29 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:57:29 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:57:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:57:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:29 INFO - 'talos_options': ['--e10s'], 14:57:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:57:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:29 INFO - 'tests': ['damp', 'tps']}, 14:57:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:29 INFO - 'talos_options': ['--e10s'], 14:57:29 INFO - 'tests': ['damp', 'tps']}, 14:57:29 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:57:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:57:29 INFO - 'other': {'tests': ['a11yr', 14:57:29 INFO - 'ts_paint', 14:57:29 INFO - 'tpaint', 14:57:29 INFO - 'sessionrestore', 14:57:29 INFO - 'sessionrestore_no_auto_restore']}, 14:57:29 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:57:29 INFO - 'tests': ['a11yr', 14:57:29 INFO - 'ts_paint', 14:57:29 INFO - 'tpaint', 14:57:29 INFO - 'sessionrestore', 14:57:29 INFO - 'sessionrestore_no_auto_restore']}, 14:57:29 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:57:29 INFO - 'tests': ['a11yr', 14:57:29 INFO - 'ts_paint', 14:57:29 INFO - 'tpaint', 14:57:29 INFO - 'sessionrestore', 14:57:29 INFO - 'sessionrestore_no_auto_restore']}, 14:57:29 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:57:29 INFO - 'tests': ['a11yr', 14:57:29 INFO - 'ts_paint', 14:57:29 INFO - 'tpaint', 14:57:29 INFO - 'sessionrestore', 14:57:29 INFO - 'sessionrestore_no_auto_restore']}, 14:57:29 INFO - 'other_l64': {'tests': ['a11yr', 14:57:29 INFO - 'ts_paint', 14:57:29 INFO - 'tpaint', 14:57:29 INFO - 'sessionrestore', 14:57:29 INFO - 'sessionrestore_no_auto_restore']}, 14:57:29 INFO - 'other_nol64': {'tests': ['a11yr', 14:57:29 INFO - 'ts_paint', 14:57:29 INFO - 'tpaint', 14:57:29 INFO - 'sessionrestore', 14:57:29 INFO - 'sessionrestore_no_auto_restore']}, 14:57:29 INFO - 'svgr': {'tests': ['tsvgx', 14:57:29 INFO - 'tsvgr_opacity', 14:57:29 INFO - 'tart', 14:57:29 INFO - 'tscrollx', 14:57:29 INFO - 'cart']}, 14:57:29 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:57:29 INFO - 'tests': ['tsvgx', 14:57:29 INFO - 'tsvgr_opacity', 14:57:29 INFO - 'tart', 14:57:29 INFO - 'tscrollx', 14:57:29 INFO - 'cart']}, 14:57:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:29 INFO - 'tests': ['tp5o']}, 14:57:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:29 INFO - 'talos_options': ['--e10s'], 14:57:29 INFO - 'tests': ['tp5o']}, 14:57:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:29 INFO - 'talos_options': ['--xperf_path', 14:57:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:57:29 INFO - 'tests': ['tp5n']}, 14:57:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:57:29 INFO - 'talos_options': ['--e10s', 14:57:29 INFO - '--xperf_path', 14:57:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:57:29 INFO - 'tests': ['tp5n']}}, 14:57:29 INFO - 'talos.zip': {'path': '', 14:57:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:57:29 INFO - Running post-action listener: _resource_record_post_action 14:57:29 INFO - ##### 14:57:29 INFO - ##### Running create-virtualenv step. 14:57:29 INFO - ##### 14:57:29 INFO - Running pre-action listener: _resource_record_pre_action 14:57:29 INFO - Running main action method: create_virtualenv 14:57:29 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:57:29 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 14:57:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:57:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:57:29 INFO - Using real prefix '/usr' 14:57:29 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:57:30 INFO - Installing distribute.............................................................................................................................................................................................done. 14:57:32 INFO - Installing pip.................done. 14:57:32 INFO - Return code: 0 14:57:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:57:32 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')]} 14:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:32 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')]} 14:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:32 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 0x7f8591bfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd7850>, '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 0xf43330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf437c0>, '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': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', '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 14:57:32 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 14:57:32 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 14:57:32 INFO - Using env: {'DISPLAY': ':0', 14:57:32 INFO - 'HOME': '/home/cltbld', 14:57:32 INFO - 'LANG': 'en_US.UTF-8', 14:57:32 INFO - 'LANGUAGE': 'en_US:en', 14:57:32 INFO - 'LOGNAME': 'cltbld', 14:57:32 INFO - 'MAIL': '/var/mail/cltbld', 14:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:32 INFO - 'MOZ_NO_REMOTE': '1', 14:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:32 INFO - 'NO_EM_RESTART': '1', 14:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:57:32 INFO - 'PWD': '/builds/slave/test-pgo', 14:57:32 INFO - 'SHELL': '/bin/bash', 14:57:32 INFO - 'SHLVL': '1', 14:57:32 INFO - 'TERM': 'linux', 14:57:32 INFO - 'TMOUT': '86400', 14:57:32 INFO - 'USER': 'cltbld', 14:57:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', 14:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:32 INFO - '_': '/tools/buildbot/bin/python'} 14:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:32 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 14:57:32 INFO - Cleaning up... 14:57:32 INFO - Return code: 0 14:57:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:57:32 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')]} 14:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:32 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')]} 14:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:32 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 0x7f8591bfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd7850>, '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 0xf43330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf437c0>, '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': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', '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 14:57:32 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 14:57:32 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 14:57:32 INFO - Using env: {'DISPLAY': ':0', 14:57:32 INFO - 'HOME': '/home/cltbld', 14:57:32 INFO - 'LANG': 'en_US.UTF-8', 14:57:32 INFO - 'LANGUAGE': 'en_US:en', 14:57:32 INFO - 'LOGNAME': 'cltbld', 14:57:32 INFO - 'MAIL': '/var/mail/cltbld', 14:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:32 INFO - 'MOZ_NO_REMOTE': '1', 14:57:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:32 INFO - 'NO_EM_RESTART': '1', 14:57:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:57:32 INFO - 'PWD': '/builds/slave/test-pgo', 14:57:32 INFO - 'SHELL': '/bin/bash', 14:57:32 INFO - 'SHLVL': '1', 14:57:32 INFO - 'TERM': 'linux', 14:57:32 INFO - 'TMOUT': '86400', 14:57:32 INFO - 'USER': 'cltbld', 14:57:32 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', 14:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:32 INFO - '_': '/tools/buildbot/bin/python'} 14:57:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:33 INFO - Downloading/unpacking psutil>=0.7.1 14:57:33 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 14:57:33 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 14:57:33 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 14:57:33 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 14:57:33 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 14:57:33 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 14:57:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:57:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:57:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:57:35 INFO - Installing collected packages: psutil 14:57:35 INFO - Running setup.py install for psutil 14:57:35 INFO - building 'psutil._psutil_linux' extension 14:57:35 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 14:57:36 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 14:57:36 INFO - building 'psutil._psutil_posix' extension 14:57:36 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 14:57:36 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 14:57:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:57:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:57:36 INFO - Successfully installed psutil 14:57:36 INFO - Cleaning up... 14:57:36 INFO - Return code: 0 14:57:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:57:36 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')]} 14:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:36 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')]} 14:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:36 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 0x7f8591bfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd7850>, '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 0xf43330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf437c0>, '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': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', '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 14:57:36 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 14:57:36 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 14:57:36 INFO - Using env: {'DISPLAY': ':0', 14:57:36 INFO - 'HOME': '/home/cltbld', 14:57:36 INFO - 'LANG': 'en_US.UTF-8', 14:57:36 INFO - 'LANGUAGE': 'en_US:en', 14:57:36 INFO - 'LOGNAME': 'cltbld', 14:57:36 INFO - 'MAIL': '/var/mail/cltbld', 14:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:36 INFO - 'MOZ_NO_REMOTE': '1', 14:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:36 INFO - 'NO_EM_RESTART': '1', 14:57:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:57:36 INFO - 'PWD': '/builds/slave/test-pgo', 14:57:36 INFO - 'SHELL': '/bin/bash', 14:57:36 INFO - 'SHLVL': '1', 14:57:36 INFO - 'TERM': 'linux', 14:57:36 INFO - 'TMOUT': '86400', 14:57:36 INFO - 'USER': 'cltbld', 14:57:36 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', 14:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:36 INFO - '_': '/tools/buildbot/bin/python'} 14:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:57:37 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 14:57:37 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 14:57:37 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 14:57:37 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 14:57:37 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 14:57:37 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 14:57:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:57:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:57:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:57:39 INFO - Installing collected packages: mozsystemmonitor 14:57:39 INFO - Running setup.py install for mozsystemmonitor 14:57:39 INFO - Successfully installed mozsystemmonitor 14:57:39 INFO - Cleaning up... 14:57:39 INFO - Return code: 0 14:57:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:57:39 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')]} 14:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:39 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')]} 14:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:39 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 0x7f8591bfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd7850>, '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 0xf43330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf437c0>, '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': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', '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 14:57:39 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 14:57:39 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 14:57:39 INFO - Using env: {'DISPLAY': ':0', 14:57:39 INFO - 'HOME': '/home/cltbld', 14:57:39 INFO - 'LANG': 'en_US.UTF-8', 14:57:39 INFO - 'LANGUAGE': 'en_US:en', 14:57:39 INFO - 'LOGNAME': 'cltbld', 14:57:39 INFO - 'MAIL': '/var/mail/cltbld', 14:57:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:39 INFO - 'MOZ_NO_REMOTE': '1', 14:57:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:39 INFO - 'NO_EM_RESTART': '1', 14:57:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:57:39 INFO - 'PWD': '/builds/slave/test-pgo', 14:57:39 INFO - 'SHELL': '/bin/bash', 14:57:39 INFO - 'SHLVL': '1', 14:57:39 INFO - 'TERM': 'linux', 14:57:39 INFO - 'TMOUT': '86400', 14:57:39 INFO - 'USER': 'cltbld', 14:57:39 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', 14:57:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:39 INFO - '_': '/tools/buildbot/bin/python'} 14:57:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:39 INFO - Downloading/unpacking blobuploader==1.2.4 14:57:39 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 14:57:39 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 14:57:39 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 14:57:39 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 14:57:39 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 14:57:39 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 14:57:41 INFO - Downloading blobuploader-1.2.4.tar.gz 14:57:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:57:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:57:41 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 14:57:41 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 14:57:41 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 14:57:41 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 14:57:41 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 14:57:41 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 14:57:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:57:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:57:41 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 14:57:41 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 14:57:41 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 14:57:41 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 14:57:41 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 14:57:41 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 14:57:41 INFO - Downloading docopt-0.6.1.tar.gz 14:57:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:57:42 INFO - Installing collected packages: blobuploader, requests, docopt 14:57:42 INFO - Running setup.py install for blobuploader 14:57:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:57:42 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:57:42 INFO - Running setup.py install for requests 14:57:42 INFO - Running setup.py install for docopt 14:57:42 INFO - Successfully installed blobuploader requests docopt 14:57:42 INFO - Cleaning up... 14:57:42 INFO - Return code: 0 14:57:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:42 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 0x7f8591bfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd7850>, '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 0xf43330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf437c0>, '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': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', '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 14:57:42 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 14:57:42 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 14:57:42 INFO - Using env: {'DISPLAY': ':0', 14:57:42 INFO - 'HOME': '/home/cltbld', 14:57:42 INFO - 'LANG': 'en_US.UTF-8', 14:57:42 INFO - 'LANGUAGE': 'en_US:en', 14:57:42 INFO - 'LOGNAME': 'cltbld', 14:57:42 INFO - 'MAIL': '/var/mail/cltbld', 14:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:42 INFO - 'MOZ_NO_REMOTE': '1', 14:57:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:42 INFO - 'NO_EM_RESTART': '1', 14:57:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:57:42 INFO - 'PWD': '/builds/slave/test-pgo', 14:57:42 INFO - 'SHELL': '/bin/bash', 14:57:42 INFO - 'SHLVL': '1', 14:57:42 INFO - 'TERM': 'linux', 14:57:42 INFO - 'TMOUT': '86400', 14:57:42 INFO - 'USER': 'cltbld', 14:57:42 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', 14:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:42 INFO - '_': '/tools/buildbot/bin/python'} 14:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:57:42 INFO - Running setup.py (path:/tmp/pip-zp2mZc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:57:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:57:42 INFO - Running setup.py (path:/tmp/pip-piJYzo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:57:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:57:43 INFO - Running setup.py (path:/tmp/pip-jyfPTN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:57:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:57:43 INFO - Running setup.py (path:/tmp/pip-9oD4fY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:57:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:57:43 INFO - Running setup.py (path:/tmp/pip-bJjnkY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:57:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:57:43 INFO - Running setup.py (path:/tmp/pip-VNe8Px-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:57:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:57:43 INFO - Running setup.py (path:/tmp/pip-YiAJY_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:57:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:57:43 INFO - Running setup.py (path:/tmp/pip-c9RI_N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:57:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:57:43 INFO - Running setup.py (path:/tmp/pip-wo5Wxw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:57:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:57:43 INFO - Running setup.py (path:/tmp/pip-rtjrCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:57:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:57:43 INFO - Running setup.py (path:/tmp/pip-ftVL8I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:57:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:57:43 INFO - Running setup.py (path:/tmp/pip-8rssqc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:57:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:57:43 INFO - Running setup.py (path:/tmp/pip-LEJxlE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:57:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:57:43 INFO - Running setup.py (path:/tmp/pip-gv_XbO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:57:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:57:43 INFO - Running setup.py (path:/tmp/pip-weuQZ5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:57:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:57:43 INFO - Running setup.py (path:/tmp/pip-hveKIu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:57:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:57:44 INFO - Running setup.py (path:/tmp/pip-afGGWV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:57:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:57:44 INFO - Running setup.py install for manifestparser 14:57:44 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:57:44 INFO - Running setup.py install for mozcrash 14:57:44 INFO - Running setup.py install for mozdebug 14:57:44 INFO - Running setup.py install for mozdevice 14:57:44 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:57:44 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:57:44 INFO - Running setup.py install for mozfile 14:57:44 INFO - Running setup.py install for mozhttpd 14:57:44 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:57:44 INFO - Running setup.py install for mozinfo 14:57:44 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:57:44 INFO - Running setup.py install for mozInstall 14:57:44 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:57:44 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:57:44 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:57:44 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:57:44 INFO - Running setup.py install for mozleak 14:57:44 INFO - Running setup.py install for mozlog 14:57:45 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:57:45 INFO - Running setup.py install for moznetwork 14:57:45 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:57:45 INFO - Running setup.py install for mozprocess 14:57:45 INFO - Running setup.py install for mozprofile 14:57:45 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:57:45 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:57:45 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:57:45 INFO - Running setup.py install for mozrunner 14:57:45 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:57:45 INFO - Running setup.py install for mozscreenshot 14:57:45 INFO - Running setup.py install for moztest 14:57:45 INFO - Running setup.py install for mozversion 14:57:45 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:57:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:57:45 INFO - Cleaning up... 14:57:45 INFO - Return code: 0 14:57:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:45 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 0x7f8591bfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd7850>, '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 0xf43330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf437c0>, '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': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', '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 14:57:45 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 14:57:45 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 14:57:45 INFO - Using env: {'DISPLAY': ':0', 14:57:45 INFO - 'HOME': '/home/cltbld', 14:57:45 INFO - 'LANG': 'en_US.UTF-8', 14:57:45 INFO - 'LANGUAGE': 'en_US:en', 14:57:45 INFO - 'LOGNAME': 'cltbld', 14:57:45 INFO - 'MAIL': '/var/mail/cltbld', 14:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:45 INFO - 'MOZ_NO_REMOTE': '1', 14:57:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:45 INFO - 'NO_EM_RESTART': '1', 14:57:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:57:45 INFO - 'PWD': '/builds/slave/test-pgo', 14:57:45 INFO - 'SHELL': '/bin/bash', 14:57:45 INFO - 'SHLVL': '1', 14:57:45 INFO - 'TERM': 'linux', 14:57:45 INFO - 'TMOUT': '86400', 14:57:45 INFO - 'USER': 'cltbld', 14:57:45 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', 14:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:45 INFO - '_': '/tools/buildbot/bin/python'} 14:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:57:46 INFO - Running setup.py (path:/tmp/pip-vx1vjK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:57:46 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)) 14:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:57:46 INFO - Running setup.py (path:/tmp/pip-plxjN3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:57:46 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)) 14:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:57:46 INFO - Running setup.py (path:/tmp/pip-KvXmNb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:57:46 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)) 14:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:57:46 INFO - Running setup.py (path:/tmp/pip-muIfKH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:57:46 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)) 14:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:57:46 INFO - Running setup.py (path:/tmp/pip-6WMtU3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:57:46 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)) 14:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:57:46 INFO - Running setup.py (path:/tmp/pip-lECBfO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:57:46 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)) 14:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:57:46 INFO - Running setup.py (path:/tmp/pip-CIg2t_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:57:46 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)) 14:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:57:46 INFO - Running setup.py (path:/tmp/pip-cPYSi9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:57:46 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)) 14:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:57:46 INFO - Running setup.py (path:/tmp/pip-5iw1c9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:57:46 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)) 14:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:57:46 INFO - Running setup.py (path:/tmp/pip-FJad6b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:57:46 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)) 14:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:57:46 INFO - Running setup.py (path:/tmp/pip-RsvxQE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:57:46 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)) 14:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:57:46 INFO - Running setup.py (path:/tmp/pip-J3bpRR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:57:46 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)) 14:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:57:46 INFO - Running setup.py (path:/tmp/pip-YQpJ4c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:57:46 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)) 14:57:46 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:57:47 INFO - Running setup.py (path:/tmp/pip-YVWehD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:57:47 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)) 14:57:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:57:47 INFO - Running setup.py (path:/tmp/pip-QYDa3V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:57:47 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)) 14:57:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:57:47 INFO - Running setup.py (path:/tmp/pip-9o_JKo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:57:47 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)) 14:57:47 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:57:47 INFO - Running setup.py (path:/tmp/pip-ZvIYtf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:57:47 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)) 14:57:47 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)) 14:57:47 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)) 14:57:47 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)) 14:57:47 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)) 14:57:47 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)) 14:57:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:49 INFO - Downloading blessings-1.6.tar.gz 14:57:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:57:49 INFO - Installing collected packages: blessings 14:57:49 INFO - Running setup.py install for blessings 14:57:49 INFO - Successfully installed blessings 14:57:49 INFO - Cleaning up... 14:57:49 INFO - Return code: 0 14:57:49 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:57:49 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:57:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:57:49 INFO - Reading from file tmpfile_stdout 14:57:49 INFO - Current package versions: 14:57:49 INFO - argparse == 1.2.1 14:57:49 INFO - blessings == 1.6 14:57:49 INFO - blobuploader == 1.2.4 14:57:49 INFO - docopt == 0.6.1 14:57:49 INFO - manifestparser == 1.1 14:57:49 INFO - mozInstall == 1.12 14:57:49 INFO - mozcrash == 0.16 14:57:49 INFO - mozdebug == 0.1 14:57:49 INFO - mozdevice == 0.48 14:57:49 INFO - mozfile == 1.2 14:57:49 INFO - mozhttpd == 0.7 14:57:49 INFO - mozinfo == 0.9 14:57:49 INFO - mozleak == 0.1 14:57:49 INFO - mozlog == 3.1 14:57:49 INFO - moznetwork == 0.27 14:57:49 INFO - mozprocess == 0.22 14:57:49 INFO - mozprofile == 0.28 14:57:49 INFO - mozrunner == 6.11 14:57:49 INFO - mozscreenshot == 0.1 14:57:49 INFO - mozsystemmonitor == 0.0 14:57:49 INFO - moztest == 0.7 14:57:49 INFO - mozversion == 1.4 14:57:49 INFO - psutil == 3.1.1 14:57:49 INFO - requests == 1.2.3 14:57:49 INFO - wsgiref == 0.1.2 14:57:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:57: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')]} 14:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57: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')]} 14:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:49 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 0x7f8591bfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd7850>, '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 0xf43330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf437c0>, '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': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', '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 14:57:49 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 14:57:49 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 14:57:49 INFO - Using env: {'DISPLAY': ':0', 14:57:49 INFO - 'HOME': '/home/cltbld', 14:57:49 INFO - 'LANG': 'en_US.UTF-8', 14:57:49 INFO - 'LANGUAGE': 'en_US:en', 14:57:49 INFO - 'LOGNAME': 'cltbld', 14:57:49 INFO - 'MAIL': '/var/mail/cltbld', 14:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:49 INFO - 'MOZ_NO_REMOTE': '1', 14:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:49 INFO - 'NO_EM_RESTART': '1', 14:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:57:49 INFO - 'PWD': '/builds/slave/test-pgo', 14:57:49 INFO - 'SHELL': '/bin/bash', 14:57:49 INFO - 'SHLVL': '1', 14:57:49 INFO - 'TERM': 'linux', 14:57:49 INFO - 'TMOUT': '86400', 14:57:49 INFO - 'USER': 'cltbld', 14:57:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', 14:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:49 INFO - '_': '/tools/buildbot/bin/python'} 14:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:49 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)) 14:57:49 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)) 14:57:49 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)) 14:57:49 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)) 14:57:49 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)) 14:57:49 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)) 14:57:49 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)) 14:57:49 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)) 14:57:49 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)) 14:57:49 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)) 14:57:49 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)) 14:57:49 INFO - Cleaning up... 14:57:49 INFO - Return code: 0 14:57:49 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:57: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')]} 14:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57: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')]} 14:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:49 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 0x7f8591bfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd7850>, '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 0xf43330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf437c0>, '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': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', '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 14:57:49 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 14:57:49 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 14:57:49 INFO - Using env: {'DISPLAY': ':0', 14:57:49 INFO - 'HOME': '/home/cltbld', 14:57:49 INFO - 'LANG': 'en_US.UTF-8', 14:57:49 INFO - 'LANGUAGE': 'en_US:en', 14:57:49 INFO - 'LOGNAME': 'cltbld', 14:57:49 INFO - 'MAIL': '/var/mail/cltbld', 14:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:49 INFO - 'MOZ_NO_REMOTE': '1', 14:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:49 INFO - 'NO_EM_RESTART': '1', 14:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:57:49 INFO - 'PWD': '/builds/slave/test-pgo', 14:57:49 INFO - 'SHELL': '/bin/bash', 14:57:49 INFO - 'SHLVL': '1', 14:57:49 INFO - 'TERM': 'linux', 14:57:49 INFO - 'TMOUT': '86400', 14:57:49 INFO - 'USER': 'cltbld', 14:57:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', 14:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:49 INFO - '_': '/tools/buildbot/bin/python'} 14:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:50 INFO - Downloading/unpacking jsonschema 14:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:57:51 INFO - Downloading/unpacking functools32 (from jsonschema) 14:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:52 INFO - Downloading functools32-3.2.3-2.tar.gz 14:57:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:57:52 INFO - warning: no files found matching '*.txt' 14:57:52 INFO - no previously-included directories found matching 'build' 14:57:52 INFO - no previously-included directories found matching 'dist' 14:57:52 INFO - no previously-included directories found matching '.git*' 14:57:52 INFO - Installing collected packages: jsonschema, functools32 14:57:52 INFO - Running setup.py install for functools32 14:57:52 INFO - warning: no files found matching '*.txt' 14:57:52 INFO - no previously-included directories found matching 'build' 14:57:52 INFO - no previously-included directories found matching 'dist' 14:57:52 INFO - no previously-included directories found matching '.git*' 14:57:52 INFO - Successfully installed jsonschema functools32 14:57:52 INFO - Cleaning up... 14:57:52 INFO - Return code: 0 14:57:52 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:57: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')]} 14:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57: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')]} 14:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:57:52 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 0x7f8591bfbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf45290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd7850>, '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 0xf43330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf437c0>, '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': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', '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 14:57:52 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 14:57:52 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 14:57:52 INFO - Using env: {'DISPLAY': ':0', 14:57:52 INFO - 'HOME': '/home/cltbld', 14:57:52 INFO - 'LANG': 'en_US.UTF-8', 14:57:52 INFO - 'LANGUAGE': 'en_US:en', 14:57:52 INFO - 'LOGNAME': 'cltbld', 14:57:52 INFO - 'MAIL': '/var/mail/cltbld', 14:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:57:52 INFO - 'MOZ_NO_REMOTE': '1', 14:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:57:52 INFO - 'NO_EM_RESTART': '1', 14:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:57:52 INFO - 'PWD': '/builds/slave/test-pgo', 14:57:52 INFO - 'SHELL': '/bin/bash', 14:57:52 INFO - 'SHLVL': '1', 14:57:52 INFO - 'TERM': 'linux', 14:57:52 INFO - 'TMOUT': '86400', 14:57:52 INFO - 'USER': 'cltbld', 14:57:52 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', 14:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:57:52 INFO - '_': '/tools/buildbot/bin/python'} 14:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:57:52 INFO - Downloading/unpacking flake8 14:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:54 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:57:54 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:54 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:57:54 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:54 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:57:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:57:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:57:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:57:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:57:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:57:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:57:55 INFO - no previously-included directories found matching 'docs/_build' 14:57:55 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:57:55 INFO - Running setup.py install for pep8 14:57:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:57:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:57:55 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:57:55 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:57:55 INFO - no previously-included directories found matching 'docs/_build' 14:57:55 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:57:55 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:57:55 INFO - Cleaning up... 14:57:55 INFO - Return code: 0 14:57:55 INFO - Running post-action listener: _resource_record_post_action 14:57:55 INFO - Running post-action listener: _start_resource_monitoring 14:57:55 INFO - Starting resource monitoring. 14:57:55 INFO - ##### 14:57:55 INFO - ##### Running install step. 14:57:55 INFO - ##### 14:57:55 INFO - Running pre-action listener: _resource_record_pre_action 14:57:55 INFO - Running main action method: install 14:57:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:57:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:57:55 INFO - Reading from file tmpfile_stdout 14:57:55 INFO - Detecting whether we're running mozinstall >=1.0... 14:57:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:57:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:57:55 INFO - Reading from file tmpfile_stdout 14:57:55 INFO - Output received: 14:57:55 INFO - Usage: mozinstall [options] installer 14:57:55 INFO - Options: 14:57:55 INFO - -h, --help show this help message and exit 14:57:55 INFO - -d DEST, --destination=DEST 14:57:55 INFO - Directory to install application into. [default: 14:57:55 INFO - "/builds/slave/test-pgo"] 14:57:55 INFO - --app=APP Application being installed. [default: firefox] 14:57:55 INFO - mkdir: /builds/slave/test-pgo/build/application 14:57:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:57:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:58:08 INFO - Reading from file tmpfile_stdout 14:58:08 INFO - Output received: 14:58:08 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:58:08 INFO - Running post-action listener: _resource_record_post_action 14:58:08 INFO - ##### 14:58:08 INFO - ##### Running run-tests step. 14:58:08 INFO - ##### 14:58:08 INFO - Running pre-action listener: _resource_record_pre_action 14:58:08 INFO - Running main action method: run_tests 14:58:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:58:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:58:08 INFO - Python 2.7.3 14:58:08 INFO - Return code: 0 14:58:08 INFO - grabbing minidump binary from tooltool 14:58: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')]} 14:58:08 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 0xfd7850>, '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 0xf43330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf437c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:58:08 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 14:58:08 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 14:58:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:58:08 INFO - Return code: 0 14:58:08 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:58:08 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:58:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:58:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:58:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:58:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:58:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:58:09 INFO - Return code: 0 14:58:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 14:58:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 14:58:09 INFO - Using env: {'DISPLAY': ':0', 14:58:09 INFO - 'HOME': '/home/cltbld', 14:58:09 INFO - 'LANG': 'en_US.UTF-8', 14:58:09 INFO - 'LANGUAGE': 'en_US:en', 14:58:09 INFO - 'LOGNAME': 'cltbld', 14:58:09 INFO - 'MAIL': '/var/mail/cltbld', 14:58:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:58:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:58:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:09 INFO - 'MOZ_NO_REMOTE': '1', 14:58:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:58:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:09 INFO - 'NO_EM_RESTART': '1', 14:58:09 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:58:09 INFO - 'PWD': '/builds/slave/test-pgo', 14:58:09 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:58:09 INFO - 'SHELL': '/bin/bash', 14:58:09 INFO - 'SHLVL': '1', 14:58:09 INFO - 'TERM': 'linux', 14:58:09 INFO - 'TMOUT': '86400', 14:58:09 INFO - 'USER': 'cltbld', 14:58:09 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111', 14:58:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:09 INFO - '_': '/tools/buildbot/bin/python'} 14:58:09 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 14:58:09 INFO - mozversion application_buildid: 20160314120416 14:58:09 INFO - mozversion application_changeset: b31b7bd99b5f4f0f5ce37fc807e2cf3f2f987cf1 14:58:09 INFO - mozversion application_display_name: Firefox 14:58:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:58:09 INFO - mozversion application_name: Firefox 14:58:09 INFO - mozversion application_remotingname: firefox 14:58:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:58:09 INFO - mozversion application_vendor: Mozilla 14:58:09 INFO - mozversion application_version: 46.0 14:58:09 INFO - mozversion platform_buildid: 20160314120416 14:58:09 INFO - mozversion platform_changeset: b31b7bd99b5f4f0f5ce37fc807e2cf3f2f987cf1 14:58:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:58:09 INFO - mozversion platform_version: 46.0 14:58:09 INFO - using testdate: 1457992689 14:58:09 INFO - actual date: 1457992689 14:58:09 INFO - starting webserver on 'localhost:44548' 14:58:09 INFO - SUITE-START | Running 3 tests 14:58:09 INFO - TEST-START | dromaeo_css 14:58:09 INFO - operating with platform_type : linux_ 14:58:09 INFO - Initialising browser for dromaeo_css test... 14:58:09 INFO - TEST-INFO | started process 3299 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqwToXq/profile http://localhost:44548/getInfo.html) 14:58:14 INFO - PROCESS | 3299 | __metrics Screen width/height:1600/1200 14:58:14 INFO - PROCESS | 3299 | colorDepth:24 14:58:14 INFO - PROCESS | 3299 | Browser inner width/height: 1024/697 14:58:14 INFO - PROCESS | 3299 | __metrics 14:58:14 INFO - PROCESS | 3299 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:58:15 INFO - TEST-INFO | 3299: exit 0 14:58:15 INFO - Browser initialized. 14:58:15 INFO - Running cycle 1/1 for dromaeo_css test... 14:58:15 INFO - TEST-INFO | started process 3386 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpqwToXq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:58:27 INFO - PROCESS | 3386 | RSS: Main: 136978432 14:58:27 INFO - PROCESS | 3386 | 14:59:18 INFO - PROCESS | 3386 | 1457992758640 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] 15:01:26 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:44548/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44548/tests/dromaeo/cssquery-ext.html) 15:01:27 INFO - PROCESS | 3386 | RSS: Main: 223420416 15:01:27 INFO - PROCESS | 3386 | 15:04:30 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:44548/tests/dromaeo/cssquery-ext.html (next: http://localhost:44548/tests/dromaeo/cssquery-jquery.html) 15:04:30 INFO - PROCESS | 3386 | RSS: Main: 213278720 15:04:30 INFO - PROCESS | 3386 | 15:07:32 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:44548/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44548/tests/dromaeo/cssquery-mootools.html) 15:07:33 INFO - PROCESS | 3386 | RSS: Main: 215400448 15:07:33 INFO - PROCESS | 3386 | 15:10:34 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:44548/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44548/tests/dromaeo/cssquery-prototype.html) 15:10:35 INFO - PROCESS | 3386 | RSS: Main: 200556544 15:10:35 INFO - PROCESS | 3386 | 15:13:37 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:44548/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44548/tests/dromaeo/cssquery-yui.html) 15:13:38 INFO - PROCESS | 3386 | RSS: Main: 201547776 15:13:38 INFO - PROCESS | 3386 | 15:16:40 INFO - PROCESS | 3386 | Cycle 1(1): loaded http://localhost:44548/tests/dromaeo/cssquery-yui.html (next: http://localhost:44548/tests/dromaeo/cssquery-dojo.html) 15:16:40 INFO - PROCESS | 3386 | RSS: Main: 248524800 15:16:40 INFO - PROCESS | 3386 | 15:16:40 INFO - PROCESS | 3386 | __start_tp_report 15:16:40 INFO - PROCESS | 3386 | _x_x_mozilla_page_load 15:16:40 INFO - PROCESS | 3386 | _x_x_mozilla_page_load_details 15:16:40 INFO - PROCESS | 3386 | |i|pagename|runs| 15:16:40 INFO - PROCESS | 3386 | |0;dojo.html;3288.4409650359435;3324.484704870746;3341.264921717223;3346.314005628846;3369.0903456066862;5338.172583249598;5364.758585863636;5365.651232669874;5382.596305277105;5396.514313711765;5362.2224777407255;5376.166694162402;5394.703291318976;5404.189371594262;5411.377691565471;4860.368152140217;4904.583110435608;4912.926306105412;4951.405831300249;4975.751212439363;4887.486813884544;4922.483139270379;4960.975195124038;4988.226824842155;4990.625703072266;4923.359963204778;4995.5753760930365;5003.249512573125;5009.348784657989;5026.371703537058;4835.468098509161;4925.21196608541;4939.728314942677;4954.2568614707725;4961.9751901240625;4799.568038876483;4825.227963525819;4874.731889746063;4894.388201474816;4906.681065730716;5273.578113750891;5282.31329927107;5285.973570132163;5291.074062039128;5337.893242135175;5765.88468230633;5803.47768700819;5816.1566572846705;5818.127280907897;5823.068309070571;5726.255586773735;5785.421457854223;5792.565557583198;5812.215350927613;5834.124881267801;5437.184422336682;5475.178723191513;5481.095619222823;5485.122380419114;5495.587830912697;5958.433948774859;5968.955432799243;5969.343372229051;5969.73136208863;5971.984762590283;5605.271314729059;5703.657780533182;5704.486596206361;5742.7702891883855;5781.53747700183;5755.1367294906095;5757.65454072757;5762.88474230513;5773.076307790733;5807.651540907559;5697.6296540724725;5719.942800572025;5732.656040637575;5742.109972954198;5745.052066408995;5539.446055394428;5597.44025597437;5650.237217975603;5713.05734553794;5769.769209231667;4450.955490445054;4456.554344565518;4463.5313292103865;4471.932921006188;4485.596296333346;4015.8795236142964;4031.677465802729;4032.052467670095;4046.3121269384274;4059.837606495766;5375.704336261465;5383.515483606416;5437.483439073281;5448.509634132947;5487.890242195133;5782.103773914966;5809.970950145223;5826.475617194473;5838.503727183237;5845.912311315334;5408.080626293539;5423.728813559306;5427.891442171213;5449.6730196188355;5452.672839629635;4903.926441103386;4949.059678661043;4989.12690279207;5039.77321020555;5045.697258164522;5795.449432303924;5801.506871915934;5801.7099145042575;5808.5062769665055;5810.244668193108;5673.0639444492845;5693.715314234355;5702.515286200553;5707.714614269353;5719.885602287848;5750.30996280449;5835.56233282497;5866.472017518273;5885.705714714333;5896.439838215363;5592.245046918614;5630.577706671934;5637.49262566371;5638.379778224474;5639.407862174413;5668.461496157858;5706.800261990977;5707.5433965281845;5709.314882214161;5710.057840456278;5548.722563871871;5578.30271216098;5634.1267103597365;5637.2107904894165;5643.830685079454;5647.124695672177;5666.093425051972;5678.630888992202;5684.431556844283;5692.886142277214;5378.40837507866;5495.53287970527;5583.804566840141;5588.357338905916;5590.776368945197;5666.065099258576;5730.312362516524;5742.655440673573;5743.7989670363;5769.567282453749;5538.501534861882;5580.916286255629;5585.888282234251;5589.888202236014;5602.635828671123 15:16:40 INFO - PROCESS | 3386 | |1;ext.html;527.1118165890475;548.6817645765456;560.4619565217391;580.7183515994742;592.2508027345409;31689.207769805766;38720.61279387205;39304.41043384344;39331.80334098333;39370.40944385833;42097.57902420975;42349.576504234945;42376.36435453463;42559.78720106403;42645;8790.956045219766;8985.550722463851;8988.505632190227;8989.640414383417;8991.910080899206;8740.694075707352;8870.112988701143;8881.111888811132;8886.155815197546;9150.084991500864;9148.588313525906;9163.129502697266;9189.954050229739;9241.49171795551;9243.53782310885;9094.181523662868;9103.63585456581;9143.13140251675;9160.404573702688;9181.816363672722;8981.326400519987;9095.63617455301;9116.179543841086;9119.088091190893;9122.954385228031;42401;42796.144077118595;42867;42884.78557607223;42917;3551.396262635358;3597.6582224688614;3658.847463049158;3716.7026637868908;3864.3237433449317;29492.26269343262;30644.84677576598;30900.69099309023;31136.065918022494;31734.365312693615;3892.2215556888737;3997.6801855851754;4312.266914624522;4364.978175109136;4400.44994375703;238903;241591;242598;426663;431003.84498077625;69603;70329.64835175792;70515.2948470519;70904.64547677229;70955.64522177356;60368;60405.39594604086;60517;60575;60597;18334.449966501026;18587.44237672872;18621.44135675932;18740.531486712942;18786.436406907815;14688.632784180481;14766.187859667607;14819.703605928036;14832.851671483362;14864.62838429048;21777.673334899988;21976.45058873509;22220.444488887584;22252.22117225922;22275.55448891013;8269.917300827035;8638.95680521606;8731.345149113842;8780.78048048791;8834.55827208637;1022.3150489172273;1036.4817591204398;1103.150574057987;1147.2370873369116;1212.2181193130382;32048;33743.66256337454;34442;34777;34799.65200348015;1123.9381833999046;1125.6679279612533;1127.8590176227972;1150.6950658075616;1154.7921374152565;14430.567082987527;15147.848521514865;15545.22273886301;15884.76172857408;16632;446635;450926;451534;453066;453361;58147;58730;58754.118688219714;58769;58812;1313.8620444853343;1412.5968171743123;1473.992630036843;1494.8280947690937;1514.0158896717003;29577;29912;34544.654553454144;35067.12332191614;35640.82179589086;48342;55611;56577.43422565722;56646.43353566576;56647.433525664215;310881;442777;448019;449022;451141;40749.38875916805;41236.79381603073;41314;41459;45354.319685204086;49840;49920.50079499158;50176.749116254185;50406.747966259936;50558.241626376366;40640.39039414352;42170.36744448775;42682.1463570733;42771.7861410691;43571;41683.58316416797;42038.57961420469;42347.7882610585;42899.78550107229;43016;41609.79195104005;41942.16115677731;42213;42251.57748422476;42403.575964239964;36099;37020.62979370279;37373.43939840959;38174.23651526898;38383;25212;28081.937054649723;28441.288967775145;28827.279318017216;30571.847140764155 15:16:40 INFO - PROCESS | 3386 | |2;jquery.html;382.4760078692192;387.0729602601769;389.1458249143132;392.5475739762878;393.0547034382312;14481.63795905103;15106.395744170248;16639.584010399733;19007.61984760304;19010.90494547527;18202.271909123618;18341;18647.440576782683;18692.906535467337;18950.147243374046;5930;6103.908441373383;6118.908216376758;6125.724342404603;6140.600860944047;4535.365048893158;4662.417197850269;4703.6237101032;6142.201513803199;6200.3179650238435;6536.93463065368;6883.3116688331265;6903.861922761542;6914.688839002257;6919.688614012382;6618.768343107968;6867.244603093655;6907.481938854581;6910.239873613898;6920.411764999981;6529.673516324212;6536.9673151634415;6537.280899101095;6539.738410463576;6573.539852210347;21529.354119376443;21693.783062169336;21980.670289945505;21995.560088798135;22381;2420.4432980414426;2464.5933420985516;2516.3960649444;2559.5776696845182;2609.6216048673027;9998.300118991674;14174.362153703109;14196.645083872883;14196.645083872985;14470.42118315266;1940.417874637603;1941.4855063408208;1943.9708404373805;1962;1973.9703904441444;58203.41796582023;59397.10904336481;60475.09287360693;60700;61205.38794612041;10867.83698244527;10895.564177432972;10896.073833724064;10930.672079837617;10940.945295273632;13745.862541374458;13849.723005539832;13954.232517211447;13970.650733731534;13988.440462381594;8497.660093596187;8575.056743758181;8645.351598630128;8675.869861952076;8765.211130998114;7844.058712954482;8073.798155046171;8320.83358332842;8633.309335253165;8693.521856297837;4443.533428989909;4642.326862604903;4830.686005409637;4861.975690121527;4991.47589503097;1908.3034692337196;1948.1622902151928;1971.5366888781125;1987.9105440255223;2006.5585571174317;949.7578117579973;977.1791694976254;1025.99487002566;1059.7191744187796;1078.6516853932585;17247.56881077958;17398.21708023142;17859.910700446413;18067;18146.818531814777;989.6981420666766;1032.4321623107412;1045.7124290820086;1090.2041509697965;1094.8357746338113;9318.48748318849;9815;9840.212782977345;9843.458609776531;9865.852012219822;545734;551702;553484;596778;599380;71820;73619;75949.24050759533;76283.61858190673;77406.6129669348;1202.8135638975973;1238.2508582307573;1247.5820600099069;1255.704909346321;1266.094742259289;15124.848751512343;16082.517524474284;16193.271302791638;16384.672306553563;16469.91765041215;32696.182595435304;32923.17692057718;33075.50386744249;33760.49359259662;36704.63295367012;43592.34611480894;45132.09735805331;45441.54558454373;46532;49245.261321079495;7593.1647518774;7754.108277548155;7798.610069496389;7885.723999659985;8064.677412903653;9983.15143212835;11048.779024419628;11127;11183.993440590386;11871.76256474883;5319.59030856831;9470.289728270269;9733.415995040321;9929.801403971736;9958.402495850272;9886.406815591088;10688.83966740484;10837.241393102408;10903.672889813319;11227.045701115496;7428.33145016951;7594.848103038019;7868.252516011199;8048.356131509582;10020.749481263027;10116.412690482139;10286.845697314397;10806.459677016275;10858.294210876267;10967.23229373968;8698.826023479369;10395.116415104801;10455.843162352723;10488.26582139243;10760.515776789907 15:16:40 INFO - PROCESS | 3386 | |3;mootools.html;1427.1651084115792;1563.8905276630637;1580.699667063258;1811.7101263797795;1938.8158124978122;7214.567125972439;7742.070951485823;7891.250331218539;7926.167752386003;7931.9206807931905;7746;7897.249761272684;7898.289153976141;7929.801754956129;7931.206879312066;2424.236365544852;2437.81716371272;2445.76765207305;2448.033026954352;2450.7304196538366;2384.880755962195;2406.193925035115;2449.9387515312083;2450.7181674107437;2471.9258422247362;2437.0251899240357;2439.4389290463205;2451.4974430241846;2463.987680061597;2469.074097213545;2353.352827972304;2384.3562238195764;2399.568077745996;2402.1952645863657;2407.9036838526526;2347.354477518696;2403.795677367426;2407.0853075831246;2411.9155829546057;2412.1798588479824;7050.153981522199;7200.423966082701;8102.878456823152;8152.714654987106;8153.796155096111;4899.55903968641;4933.062718083588;4977.576905962997;4986.87532811679;4996.90006199874;3247.691469310412;3254.4142054430195;3260.951085733716;3312.4368857294317;3344.7156991655497;1029.1201023125195;1049.7008352619544;1051.4900273367412;1071.1698433713934;1077.7251800790748;10676.199285053652;10784.892151078468;10786;11096.167787415976;11097.722556936142;4437.29003359461;4473.3960915276675;4489.057297967398;4516.209663308908;4520.728756274634;9591.376560523544;9593.328467007383;9595.23238140947;9597.712068637951;9605.903940960641;4969.726665033386;4995.475475075137;5005.174146265826;5005.774740136702;5005.849824505271;4562.452505699271;4573.085382923428;4579.335996280587;4581.106684196617;4581.198290299184;3796.7532110412735;3821.3694740367528;3827.827747751358;3875;3885.106425522146;1223.3760782001243;1246.5761641041909;1247.002398081531;1253.6051143889645;1256.1458208418362;1415.5611760354323;1416.362636813438;1432.6633241188313;1440.7118576284786;1447.4933773179514;7706.691732330756;7709.460337776414;7762.340201082859;7763.92236077632;7773.650185741655;520.4353276694828;535.2987586262009;536.4742552298691;537.2746791830997;539.9730013499309;5750.396208398141;5906.8818623627285;5963.970180149158;5968.791092311748;5972.671503067373;9115.134062264075;9591.136797688241;9614.95192524033;9727.221822254203;9766.853497197548;9503.429794212369;9530.142287194185;9599.712008639752;9645.421274723398;10025.649102281384;7808.492447990976;7812.843743125106;7813.296803287618;7913.089994650573;7913.604319783988;7754.88367674474;7764.107127680163;7831.84336313282;7852.960735196288;7855.5286682799215;8762.430442021503;8817.589185730252;8915.331350148635;8990.640374384951;9122.589483473392;9089.954550227207;9096.363254572116;9105.77235569116;9241.907580924104;9257.67598134062;7398.667059982206;7449.702011919462;7453.105627324756;7459.962700186681;7471.103467583925;7694.07671079474;7970.561619111005;7976.92023079785;7986.041674999037;7989.840203195788;7514.549127052394;7636.847263054597;7644.541327520366;7668.348190403655;7733.033370828646;7486.588237646982;7502.662380193014;7508.511946723445;7516.8496630066;7558.962205188939;7541.208173141741;7707.730229441942;7711.691532338644;7713.922860771545;7718.3053525183;7052.400545953446;7097.716091356495;7105.147382314155;7151.749688760869;7172.748953786592;6791.864162716619;6916.654167291515;6937.618430986344;6940.722371105099;7154.928450715634 15:16:40 INFO - PROCESS | 3386 | |4;prototype.html;345.7320576553171;352.99999999999994;364.1914948813636;364.9945250821238;371.1482148469263;6050.2437195350585;6076.665783381913;6087.086936959453;6090.725917333725;6115.663638499881;5709.914351284734;5824.242848429709;5830.096335068071;5968.164456976016;5998.370171132034;4723.126221649006;4732.976335118319;4754.786034628432;4757.096151731177;4764.475907650156;4515.096980603876;4747.881302967419;4752.263399173134;4755.239161734124;4758.214894542413;4550.453945526541;4591.104734576759;4697.17799385108;4702.05958808238;4702.952970470285;4677.789499472532;4686.297055441677;4692.507286734912;4696.718196908162;4705.200115980291;4167.770772607505;4172.415861779354;4177.498700156001;4179.331306990897;4180.143070670505;5562.7774889004395;5738.770449182028;5745.6552606843725;5746.281714785652;5746.597738158331;5349.43830897754;5382.703951282678;5421.1597202433295;5423.891522169574;5424.538914192299;6411.87176256477;6416.967915160441;6418.454431373339;6420.93579064208;6422.068800023971;4517.457905051382;4518.683692141552;4522.570355816225;4525.570070843265;4532.4787649420405;6558.540902136852;6613.966930165367;6662.933370666328;6663.500237482208;6674.966625166843;4658.906821863611;4658.95341046592;4660.4174478190225;4661.974365639554;4667.836625718083;4722.858314250578;4724.4094488188975;4725.480197178307;4728.881777955578;4730.668853180313;5407.242985981966;5414.648047876875;5415.268938693226;5420;5420.430854760193;6305.905411418832;6443.29123796382;6443.326019701772;6450.096986421905;6454.741810327534;1636.5663099278702;1662.4098445052075;1663.4011755767913;1664.9167541622871;1665.6335606166624;1120.6750042487588;1132.9943350283195;1135.3074624479061;1149.7642983188425;1150.5052827284348;6195.690215489208;6202.28673702521;6209.96895015531;6211.503079753609;6211.813645590549;6417.839554011093;6643.534952553275;6651.301613330627;6659.833504162435;6664.500162487833;6108.389161083945;6137.864495068427;6237.126802247689;6249.6562689052535;6252.218472690914;3558.323918455537;3606.945895811565;3608.7473876828894;3610.8736194233074;3611.5124458198334;6728.529002969745;6856.725730970805;6860.108185935796;6868.450523958071;6870.141232345957;6820.454363650896;6825.249222585511;6829.146356705412;6831.59010459374;6832.6925288362145;6825.69284382204;6838.384545390939;6845.657717114124;6848;6857.348551887562;6578.671066446755;6689.933100668931;6690.83272918181;6691.498137639794;6691.966540167268;6579.144711187707;6580.539362244788;6582.736690532517;6582.901256481253;6587.538872279086;6851.07510486078;6858.3827455529245;6862.210845752603;6863;6865.588064716133;4485.6860019798305;4606.585407313358;4609.4699109602825;4613.377194078891;4615.561521655437;6666.100076489612;6668.066470694203;6674.499412543982;6682.131322927989;6682.699278532575;6504;6511.837204069936;6529.575577587441;6595.241547222131;6597.736090556324;6377.649229292433;6493.707783149675;6497.675116244074;6503.934960650522;6510;6377.808665740035;6385.8722825544155;6386.904196436964;6395.840103997437;6396.872062558816;6541.247756508063;6553.082568440517;6555.836104097436;6609.900851487136;6616.106825578485;6288.434040936338;6303.275123360872;6373.553851230369;6386.648734319657;6393.680315984275 15:16:40 INFO - PROCESS | 3386 | |5;yui.html;783.6003638144545;838.1827717974975;893.8703887936249;898.9505577193255;914.4376208631694;14544;14569.12585244886;14675.266236688176;14721.926390368046;14743.70512589749;14028.789568156486;14059.929700351484;14083.507077252298;14126.78809817851;14161.50434734782;753.2580408297822;767.5816679909462;892.8883889513794;900.9729708108767;927.3091546797646;905.6649039855263;905.959231834569;907.5054095517959;911.1526280559077;914.8764916736222;967.7048500207434;967.7435479597913;968.8934217236099;970.8883478399969;971.4365667912629;794.2454668065332;804.2199066905092;945.394947233771;960.2414092866627;973.2214228617078;717.2648035763384;717.8205448637841;718.532953580177;718.8777907755695;718.9928100718978;14249.928750356183;14273.714525709427;14298.28508574567;14319.498817541336;14322.713545729132;13560.59318220455;13933.721325573431;13975.65060873476;14095.78856317156;14117.858821411757;11438.885611143949;11522.827157592643;11554.94222528882;11582.94208528952;11683.240589361749;3910.7849068301234;3913.6477717005605;3926.2147570486018;3981.542122655903;4023.959760402417;50251.24623130619;51685.483145168444;52145.47854521482;52174;52312.47687523152;10861.945690271497;10881.673549793519;10901;11001.394923279297;11124.55501779936;19129;19169.233230670896;19404;19411.805881941284;19418.902905485666;8145.266925976691;8311.750647480585;8410.243078122998;8432.831343373098;8469.745907622659;4614.930776038362;4626.190416677068;4628.976855115703;4636.420447444069;4689.390379250675;3275.934481310408;3311.403947289463;3312.0560640217423;3312.635610082889;3314.8674053037607;568.3549171690079;587.6356658871528;591.1782622155208;594.432317137133;602.8161410769758;521.5254118751993;593.6883136353449;685.4345165238698;705.5519744961883;708.3058602569511;8426.325893928471;9215.354925155309;9253;9901.40591564494;9984.500774961223;592.7688201601379;619.3775255867824;653.7646447278976;702.6556987076398;778.1328780991263;4044.3933409988736;4490.326451032306;4538.636909047268;4550.2492088804975;4632.420947381577;60818;63088;63206.683966579876;63239.36760632427;63309.68345158337;52917.47082529125;53921;54738;55171;55693.164602531;50233.497665022885;50552;50811;50946.74526627343;51051;9650.469224192737;9667.226621870093;9857.457839818879;9931.106200441995;10039.548220329956;35421.291574168885;35803.82098089493;36545;36637.63362366342;36902;44589;48215.5178448211;48476.5152348472;51228;52720.472795271555;12381.814272785736;12570.748585028432;12623.242605443702;12627.052971027026;12927.676808079874;13430.798538021741;13762.449502019806;13777.448902043807;13873;14009;11594.594189203337;12346.3826808661;12384.195027323196;12486.875131248571;12672.619821405373;11621.360825154698;11759.235649682743;11780.587679431179;12046.216995895238;12346.320952347347;11399;11925.165238433226;11952.342621155572;11961.401929903295;12127.939360303142;9431.669891553762;9596.328257021942;9722.465264410524;10062.547185376821;10314.329568578018;10478.94760526223;10787;10839.458027098455;10867;10885.945570272099 15:16:40 INFO - PROCESS | 3386 | __end_tp_report 15:16:40 INFO - PROCESS | 3386 | __start_cc_report 15:16:40 INFO - PROCESS | 3386 | _x_x_mozilla_cycle_collect,699 15:16:40 INFO - PROCESS | 3386 | __end_cc_report 15:16:40 INFO - PROCESS | 3386 | __startTimestamp1457993800958__endTimestamp 15:16:40 INFO - PROCESS | 3386 | 15:16:40 INFO - PROCESS | 3386 | ------- Summary: start ------- 15:16:40 INFO - PROCESS | 3386 | Number of tests: 6 15:16:40 INFO - PROCESS | 3386 | 15:16:40 INFO - PROCESS | 3386 | [#0] dojo.html Cycles:165 Average:5360.52 Median:5583.80 stddev:562.80 (10.1%) stddev-sans-first:540.54 15:16:40 INFO - PROCESS | 3386 | Values: 3288.4 3324.5 3341.3 3346.3 3369.1 5338.2 5364.8 5365.7 5382.6 5396.5 5362.2 5376.2 5394.7 5404.2 5411.4 4860.4 4904.6 4912.9 4951.4 4975.8 4887.5 4922.5 4961.0 4988.2 4990.6 4923.4 4995.6 5003.2 5009.3 5026.4 4835.5 4925.2 4939.7 4954.3 4962.0 4799.6 4825.2 4874.7 4894.4 4906.7 5273.6 5282.3 5286.0 5291.1 5337.9 5765.9 5803.5 5816.2 5818.1 5823.1 5726.3 5785.4 5792.6 5812.2 5834.1 5437.2 5475.2 5481.1 5485.1 5495.6 5958.4 5969.0 5969.3 5969.7 5972.0 5605.3 5703.7 5704.5 5742.8 5781.5 5755.1 5757.7 5762.9 5773.1 5807.7 5697.6 5719.9 5732.7 5742.1 5745.1 5539.4 5597.4 5650.2 5713.1 5769.8 4451.0 4456.6 4463.5 4471.9 4485.6 4015.9 4031.7 4032.1 4046.3 4059.8 5375.7 5383.5 5437.5 5448.5 5487.9 5782.1 5810.0 5826.5 5838.5 5845.9 5408.1 5423.7 5427.9 5449.7 5452.7 4903.9 4949.1 4989.1 5039.8 5045.7 5795.4 5801.5 5801.7 5808.5 5810.2 5673.1 5693.7 5702.5 5707.7 5719.9 5750.3 5835.6 5866.5 5885.7 5896.4 5592.2 5630.6 5637.5 5638.4 5639.4 5668.5 5706.8 5707.5 5709.3 5710.1 5548.7 5578.3 5634.1 5637.2 5643.8 5647.1 5666.1 5678.6 5684.4 5692.9 5378.4 5495.5 5583.8 5588.4 5590.8 5666.1 5730.3 5742.7 5743.8 5769.6 5538.5 5580.9 5585.9 5589.9 5602.6 15:16:40 INFO - PROCESS | 3386 | 15:16:40 INFO - PROCESS | 3386 | [#1] ext.html Cycles:180 Average:57619.67 Median:42362.97 stddev:106899.83 (252.3%) stddev-sans-first:107113.77 15:16:40 INFO - PROCESS | 3386 | Values: 527.1 548.7 560.5 580.7 592.3 31689.2 38720.6 39304.4 39331.8 39370.4 42097.6 42349.6 42376.4 42559.8 42645.0 8791.0 8985.6 8988.5 8989.6 8991.9 8740.7 8870.1 8881.1 8886.2 9150.1 9148.6 9163.1 9190.0 9241.5 9243.5 9094.2 9103.6 9143.1 9160.4 9181.8 8981.3 9095.6 9116.2 9119.1 9123.0 42401.0 42796.1 42867.0 42884.8 42917.0 3551.4 3597.7 3658.8 3716.7 3864.3 29492.3 30644.8 30900.7 31136.1 31734.4 3892.2 3997.7 4312.3 4365.0 4400.4 238903.0 241591.0 242598.0 426663.0 431003.8 69603.0 70329.6 70515.3 70904.6 70955.6 60368.0 60405.4 60517.0 60575.0 60597.0 18334.4 18587.4 18621.4 18740.5 18786.4 14688.6 14766.2 14819.7 14832.9 14864.6 21777.7 21976.5 22220.4 22252.2 22275.6 8269.9 8639.0 8731.3 8780.8 8834.6 1022.3 1036.5 1103.2 1147.2 1212.2 32048.0 33743.7 34442.0 34777.0 34799.7 1123.9 1125.7 1127.9 1150.7 1154.8 14430.6 15147.8 15545.2 15884.8 16632.0 446635.0 450926.0 451534.0 453066.0 453361.0 58147.0 58730.0 58754.1 58769.0 58812.0 1313.9 1412.6 1474.0 1494.8 1514.0 29577.0 29912.0 34544.7 35067.1 35640.8 48342.0 55611.0 56577.4 56646.4 56647.4 310881.0 442777.0 448019.0 449022.0 451141.0 40749.4 41236.8 41314.0 41459.0 45354.3 49840.0 49920.5 50176.7 50406.7 50558.2 40640.4 42170.4 42682.1 42771.8 43571.0 41683.6 42038.6 42347.8 42899.8 43016.0 41609.8 41942.2 42213.0 42251.6 42403.6 36099.0 37020.6 37373.4 38174.2 38383.0 25212.0 28081.9 28441.3 28827.3 30571.8 15:16:40 INFO - PROCESS | 3386 | 15:16:40 INFO - PROCESS | 3386 | [#2] jquery.html Cycles:180 Average:29281.15 Median:388.11 stddev:93016.86 (23966.7%) stddev-sans-first:93252.48 15:16:40 INFO - PROCESS | 3386 | Values: 382.5 387.1 389.1 392.5 393.1 14481.6 15106.4 16639.6 19007.6 19010.9 18202.3 18341.0 18647.4 18692.9 18950.1 5930.0 6103.9 6118.9 6125.7 6140.6 4535.4 4662.4 4703.6 6142.2 6200.3 6536.9 6883.3 6903.9 6914.7 6919.7 6618.8 6867.2 6907.5 6910.2 6920.4 6529.7 6537.0 6537.3 6539.7 6573.5 21529.4 21693.8 21980.7 21995.6 22381.0 2420.4 2464.6 2516.4 2559.6 2609.6 9998.3 14174.4 14196.6 14196.6 14470.4 1940.4 1941.5 1944.0 1962.0 1974.0 58203.4 59397.1 60475.1 60700.0 61205.4 10867.8 10895.6 10896.1 10930.7 10940.9 13745.9 13849.7 13954.2 13970.7 13988.4 8497.7 8575.1 8645.4 8675.9 8765.2 7844.1 8073.8 8320.8 8633.3 8693.5 4443.5 4642.3 4830.7 4862.0 4991.5 1908.3 1948.2 1971.5 1987.9 2006.6 949.8 977.2 1026.0 1059.7 1078.7 17247.6 17398.2 17859.9 18067.0 18146.8 989.7 1032.4 1045.7 1090.2 1094.8 9318.5 9815.0 9840.2 9843.5 9865.9 545734.0 551702.0 553484.0 596778.0 599380.0 71820.0 73619.0 75949.2 76283.6 77406.6 1202.8 1238.3 1247.6 1255.7 1266.1 15124.8 16082.5 16193.3 16384.7 16469.9 32696.2 32923.2 33075.5 33760.5 36704.6 43592.3 45132.1 45441.5 46532.0 49245.3 7593.2 7754.1 7798.6 7885.7 8064.7 9983.2 11048.8 11127.0 11184.0 11871.8 5319.6 9470.3 9733.4 9929.8 9958.4 9886.4 10688.8 10837.2 10903.7 11227.0 7428.3 7594.8 7868.3 8048.4 10020.7 10116.4 10286.8 10806.5 10858.3 10967.2 8698.8 10395.1 10455.8 10488.3 10760.5 15:16:40 INFO - PROCESS | 3386 | 15:16:40 INFO - PROCESS | 3386 | [#3] mootools.html Cycles:180 Average:5747.64 Median:6382.27 stddev:2960.76 (46.4%) stddev-sans-first:2951.25 15:16:40 INFO - PROCESS | 3386 | Values: 1427.2 1563.9 1580.7 1811.7 1938.8 7214.6 7742.1 7891.3 7926.2 7931.9 7746.0 7897.2 7898.3 7929.8 7931.2 2424.2 2437.8 2445.8 2448.0 2450.7 2384.9 2406.2 2449.9 2450.7 2471.9 2437.0 2439.4 2451.5 2464.0 2469.1 2353.4 2384.4 2399.6 2402.2 2407.9 2347.4 2403.8 2407.1 2411.9 2412.2 7050.2 7200.4 8102.9 8152.7 8153.8 4899.6 4933.1 4977.6 4986.9 4996.9 3247.7 3254.4 3261.0 3312.4 3344.7 1029.1 1049.7 1051.5 1071.2 1077.7 10676.2 10784.9 10786.0 11096.2 11097.7 4437.3 4473.4 4489.1 4516.2 4520.7 9591.4 9593.3 9595.2 9597.7 9605.9 4969.7 4995.5 5005.2 5005.8 5005.8 4562.5 4573.1 4579.3 4581.1 4581.2 3796.8 3821.4 3827.8 3875.0 3885.1 1223.4 1246.6 1247.0 1253.6 1256.1 1415.6 1416.4 1432.7 1440.7 1447.5 7706.7 7709.5 7762.3 7763.9 7773.7 520.4 535.3 536.5 537.3 540.0 5750.4 5906.9 5964.0 5968.8 5972.7 9115.1 9591.1 9615.0 9727.2 9766.9 9503.4 9530.1 9599.7 9645.4 10025.6 7808.5 7812.8 7813.3 7913.1 7913.6 7754.9 7764.1 7831.8 7853.0 7855.5 8762.4 8817.6 8915.3 8990.6 9122.6 9090.0 9096.4 9105.8 9241.9 9257.7 7398.7 7449.7 7453.1 7460.0 7471.1 7694.1 7970.6 7976.9 7986.0 7989.8 7514.5 7636.8 7644.5 7668.3 7733.0 7486.6 7502.7 7508.5 7516.8 7559.0 7541.2 7707.7 7711.7 7713.9 7718.3 7052.4 7097.7 7105.1 7151.7 7172.7 6791.9 6916.7 6937.6 6940.7 7154.9 15:16:40 INFO - PROCESS | 3386 | 15:16:40 INFO - PROCESS | 3386 | [#4] prototype.html Cycles:180 Average:5411.37 Median:6126.76 stddev:1608.15 (26.2%) stddev-sans-first:1567.07 15:16:40 INFO - PROCESS | 3386 | Values: 345.7 353.0 364.2 365.0 371.1 6050.2 6076.7 6087.1 6090.7 6115.7 5709.9 5824.2 5830.1 5968.2 5998.4 4723.1 4733.0 4754.8 4757.1 4764.5 4515.1 4747.9 4752.3 4755.2 4758.2 4550.5 4591.1 4697.2 4702.1 4703.0 4677.8 4686.3 4692.5 4696.7 4705.2 4167.8 4172.4 4177.5 4179.3 4180.1 5562.8 5738.8 5745.7 5746.3 5746.6 5349.4 5382.7 5421.2 5423.9 5424.5 6411.9 6417.0 6418.5 6420.9 6422.1 4517.5 4518.7 4522.6 4525.6 4532.5 6558.5 6614.0 6662.9 6663.5 6675.0 4658.9 4659.0 4660.4 4662.0 4667.8 4722.9 4724.4 4725.5 4728.9 4730.7 5407.2 5414.6 5415.3 5420.0 5420.4 6305.9 6443.3 6443.3 6450.1 6454.7 1636.6 1662.4 1663.4 1664.9 1665.6 1120.7 1133.0 1135.3 1149.8 1150.5 6195.7 6202.3 6210.0 6211.5 6211.8 6417.8 6643.5 6651.3 6659.8 6664.5 6108.4 6137.9 6237.1 6249.7 6252.2 3558.3 3606.9 3608.7 3610.9 3611.5 6728.5 6856.7 6860.1 6868.5 6870.1 6820.5 6825.2 6829.1 6831.6 6832.7 6825.7 6838.4 6845.7 6848.0 6857.3 6578.7 6689.9 6690.8 6691.5 6692.0 6579.1 6580.5 6582.7 6582.9 6587.5 6851.1 6858.4 6862.2 6863.0 6865.6 4485.7 4606.6 4609.5 4613.4 4615.6 6666.1 6668.1 6674.5 6682.1 6682.7 6504.0 6511.8 6529.6 6595.2 6597.7 6377.6 6493.7 6497.7 6503.9 6510.0 6377.8 6385.9 6386.9 6395.8 6396.9 6541.2 6553.1 6555.8 6609.9 6616.1 6288.4 6303.3 6373.6 6386.6 6393.7 15:16:40 INFO - PROCESS | 3386 | 15:16:40 INFO - PROCESS | 3386 | [#5] yui.html Cycles:180 Average:14939.42 Median:4630.70 stddev:17215.09 (371.8%) stddev-sans-first:17230.56 15:16:40 INFO - PROCESS | 3386 | Values: 783.6 838.2 893.9 899.0 914.4 14544.0 14569.1 14675.3 14721.9 14743.7 14028.8 14059.9 14083.5 14126.8 14161.5 753.3 767.6 892.9 901.0 927.3 905.7 906.0 907.5 911.2 914.9 967.7 967.7 968.9 970.9 971.4 794.2 804.2 945.4 960.2 973.2 717.3 717.8 718.5 718.9 719.0 14249.9 14273.7 14298.3 14319.5 14322.7 13560.6 13933.7 13975.7 14095.8 14117.9 11438.9 11522.8 11554.9 11582.9 11683.2 3910.8 3913.6 3926.2 3981.5 4024.0 50251.2 51685.5 52145.5 52174.0 52312.5 10861.9 10881.7 10901.0 11001.4 11124.6 19129.0 19169.2 19404.0 19411.8 19418.9 8145.3 8311.8 8410.2 8432.8 8469.7 4614.9 4626.2 4629.0 4636.4 4689.4 3275.9 3311.4 3312.1 3312.6 3314.9 568.4 587.6 591.2 594.4 602.8 521.5 593.7 685.4 705.6 708.3 8426.3 9215.4 9253.0 9901.4 9984.5 592.8 619.4 653.8 702.7 778.1 4044.4 4490.3 4538.6 4550.2 4632.4 60818.0 63088.0 63206.7 63239.4 63309.7 52917.5 53921.0 54738.0 55171.0 55693.2 50233.5 50552.0 50811.0 50946.7 51051.0 9650.5 9667.2 9857.5 9931.1 10039.5 35421.3 35803.8 36545.0 36637.6 36902.0 44589.0 48215.5 48476.5 51228.0 52720.5 12381.8 12570.7 12623.2 12627.1 12927.7 13430.8 13762.4 13777.4 13873.0 14009.0 11594.6 12346.4 12384.2 12486.9 12672.6 11621.4 11759.2 11780.6 12046.2 12346.3 11399.0 11925.2 11952.3 11961.4 12127.9 9431.7 9596.3 9722.5 10062.5 10314.3 10478.9 10787.0 10839.5 10867.0 10885.9 15:16:40 INFO - PROCESS | 3386 | -------- Summary: end -------- 15:16:40 INFO - PROCESS | 3386 | 15:16:41 INFO - TEST-INFO | 3386: exit 0 15:16:41 INFO - TEST-OK | dromaeo_css | took 1112040ms 15:16:41 INFO - TEST-START | kraken 15:16:41 INFO - operating with platform_type : linux_ 15:16:41 INFO - Initialising browser for kraken test... 15:16:41 INFO - TEST-INFO | started process 3578 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIieBCW/profile http://localhost:44548/getInfo.html) 15:16:45 INFO - PROCESS | 3578 | __metrics Screen width/height:1600/1200 15:16:45 INFO - PROCESS | 3578 | colorDepth:24 15:16:45 INFO - PROCESS | 3578 | Browser inner width/height: 1024/697 15:16:45 INFO - PROCESS | 3578 | __metrics 15:16:45 INFO - PROCESS | 3578 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:16:46 INFO - TEST-INFO | 3578: exit 0 15:16:46 INFO - Browser initialized. 15:16:46 INFO - Running cycle 1/1 for kraken test... 15:16:46 INFO - TEST-INFO | started process 3665 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIieBCW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:16:58 INFO - PROCESS | 3665 | RSS: Main: 136290304 15:16:58 INFO - PROCESS | 3665 | 15:17:00 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:44548/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44548/tests/kraken/driver.html?testName=audio-beat-detection) 15:17:01 INFO - PROCESS | 3665 | RSS: Main: 170110976 15:17:01 INFO - PROCESS | 3665 | 15:17:04 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:44548/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44548/tests/kraken/driver.html?testName=audio-dft) 15:17:04 INFO - PROCESS | 3665 | RSS: Main: 166490112 15:17:04 INFO - PROCESS | 3665 | 15:17:07 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:44548/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44548/tests/kraken/driver.html?testName=audio-fft) 15:17:07 INFO - PROCESS | 3665 | RSS: Main: 166531072 15:17:07 INFO - PROCESS | 3665 | 15:17:09 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:44548/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44548/tests/kraken/driver.html?testName=audio-oscillator) 15:17:10 INFO - PROCESS | 3665 | RSS: Main: 166830080 15:17:10 INFO - PROCESS | 3665 | 15:17:12 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:44548/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44548/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:17:13 INFO - PROCESS | 3665 | RSS: Main: 163409920 15:17:13 INFO - PROCESS | 3665 | 15:17:16 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:44548/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44548/tests/kraken/driver.html?testName=imaging-darkroom) 15:17:16 INFO - PROCESS | 3665 | RSS: Main: 164085760 15:17:16 INFO - PROCESS | 3665 | 15:17:20 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:44548/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44548/tests/kraken/driver.html?testName=imaging-desaturate) 15:17:20 INFO - PROCESS | 3665 | RSS: Main: 165109760 15:17:20 INFO - PROCESS | 3665 | 15:17:23 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:44548/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44548/tests/kraken/driver.html?testName=json-parse-financial) 15:17:24 INFO - PROCESS | 3665 | RSS: Main: 163999744 15:17:24 INFO - PROCESS | 3665 | 15:17:25 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:44548/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44548/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:17:26 INFO - PROCESS | 3665 | RSS: Main: 167333888 15:17:26 INFO - PROCESS | 3665 | 15:17:27 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:44548/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44548/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:17:28 INFO - PROCESS | 3665 | RSS: Main: 167018496 15:17:28 INFO - PROCESS | 3665 | 15:17:30 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:44548/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44548/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:17:31 INFO - PROCESS | 3665 | RSS: Main: 169246720 15:17:31 INFO - PROCESS | 3665 | 15:17:34 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:44548/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44548/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:17:34 INFO - PROCESS | 3665 | RSS: Main: 173592576 15:17:34 INFO - PROCESS | 3665 | 15:17:37 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:44548/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44548/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:17:37 INFO - PROCESS | 3665 | RSS: Main: 173228032 15:17:37 INFO - PROCESS | 3665 | 15:17:39 INFO - PROCESS | 3665 | Cycle 1(1): loaded http://localhost:44548/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44548/tests/kraken/driver.html?testName=ai-astar) 15:17:39 INFO - PROCESS | 3665 | RSS: Main: 233689088 15:17:39 INFO - PROCESS | 3665 | 15:17:39 INFO - PROCESS | 3665 | __start_tp_report 15:17:39 INFO - PROCESS | 3665 | _x_x_mozilla_page_load 15:17:39 INFO - PROCESS | 3665 | _x_x_mozilla_page_load_details 15:17:39 INFO - PROCESS | 3665 | |i|pagename|runs| 15:17:39 INFO - PROCESS | 3665 | |0;ai-astar;112;113;107;110;110;109;98;110;109;109 15:17:39 INFO - PROCESS | 3665 | |1;audio-beat-detection;146;131;160;168;124;151;150;125;158;123 15:17:39 INFO - PROCESS | 3665 | |2;audio-dft;160;160;161;160;159;162;160;162;160;161 15:17:39 INFO - PROCESS | 3665 | |3;audio-fft;72;73;74;156;76;74;72;73;145;77 15:17:39 INFO - PROCESS | 3665 | |4;audio-oscillator;95;95;139;95;95;96;145;95;95;145 15:17:39 INFO - PROCESS | 3665 | |5;imaging-gaussian-blur;110;109;109;109;109;109;109;109;108;109 15:17:39 INFO - PROCESS | 3665 | |6;imaging-darkroom;146;145;145;145;146;146;147;146;145;145 15:17:39 INFO - PROCESS | 3665 | |7;imaging-desaturate;96;95;96;95;96;96;96;96;96;96 15:17:39 INFO - PROCESS | 3665 | |8;json-parse-financial;57;57;57;55;56;56;56;56;54;56 15:17:39 INFO - PROCESS | 3665 | |9;json-stringify-tinderbox;64;64;64;64;65;80;64;65;65;65 15:17:39 INFO - PROCESS | 3665 | |10;stanford-crypto-aes;77;79;78;78;86;78;78;80;79;79 15:17:39 INFO - PROCESS | 3665 | |11;stanford-crypto-ccm;111;114;113;111;125;114;115;111;112;111 15:17:39 INFO - PROCESS | 3665 | |12;stanford-crypto-pbkdf2;128;135;135;144;134;124;134;126;138;149 15:17:39 INFO - PROCESS | 3665 | |13;stanford-crypto-sha256-iterative;64;63;65;64;63;64;63;62;64;63 15:17:39 INFO - PROCESS | 3665 | __end_tp_report 15:17:39 INFO - PROCESS | 3665 | __start_cc_report 15:17:39 INFO - PROCESS | 3665 | _x_x_mozilla_cycle_collect,915 15:17:39 INFO - PROCESS | 3665 | __end_cc_report 15:17:39 INFO - PROCESS | 3665 | __startTimestamp1457993859616__endTimestamp 15:17:39 INFO - PROCESS | 3665 | 15:17:39 INFO - PROCESS | 3665 | ------- Summary: start ------- 15:17:39 INFO - PROCESS | 3665 | Number of tests: 14 15:17:39 INFO - PROCESS | 3665 | 15:17:39 INFO - PROCESS | 3665 | [#0] ai-astar Cycles:10 Average:108.70 Median:110.00 stddev:4.11 (3.7%) stddev-sans-first:4.18 15:17:39 INFO - PROCESS | 3665 | Values: 112.0 113.0 107.0 110.0 110.0 109.0 98.0 110.0 109.0 109.0 15:17:39 INFO - PROCESS | 3665 | 15:17:39 INFO - PROCESS | 3665 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:150.50 stddev:16.62 (11.0%) stddev-sans-first:17.61 15:17:39 INFO - PROCESS | 3665 | Values: 146.0 131.0 160.0 168.0 124.0 151.0 150.0 125.0 158.0 123.0 15:17:39 INFO - PROCESS | 3665 | 15:17:39 INFO - PROCESS | 3665 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 15:17:39 INFO - PROCESS | 3665 | Values: 160.0 160.0 161.0 160.0 159.0 162.0 160.0 162.0 160.0 161.0 15:17:39 INFO - PROCESS | 3665 | 15:17:39 INFO - PROCESS | 3665 | [#3] audio-fft Cycles:10 Average:89.20 Median:73.50 stddev:32.45 (44.2%) stddev-sans-first:33.82 15:17:39 INFO - PROCESS | 3665 | Values: 72.0 73.0 74.0 156.0 76.0 74.0 72.0 73.0 145.0 77.0 15:17:39 INFO - PROCESS | 3665 | 15:17:39 INFO - PROCESS | 3665 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:95.00 stddev:23.18 (24.4%) stddev-sans-first:23.98 15:17:39 INFO - PROCESS | 3665 | Values: 95.0 95.0 139.0 95.0 95.0 96.0 145.0 95.0 95.0 145.0 15:17:39 INFO - PROCESS | 3665 | 15:17:39 INFO - PROCESS | 3665 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 15:17:39 INFO - PROCESS | 3665 | Values: 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 108.0 109.0 15:17:39 INFO - PROCESS | 3665 | 15:17:39 INFO - PROCESS | 3665 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 15:17:39 INFO - PROCESS | 3665 | Values: 146.0 145.0 145.0 145.0 146.0 146.0 147.0 146.0 145.0 145.0 15:17:39 INFO - PROCESS | 3665 | 15:17:39 INFO - PROCESS | 3665 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:17:39 INFO - PROCESS | 3665 | Values: 96.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 15:17:39 INFO - PROCESS | 3665 | 15:17:39 INFO - PROCESS | 3665 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:56.00 stddev:0.94 (1.7%) stddev-sans-first:0.93 15:17:39 INFO - PROCESS | 3665 | Values: 57.0 57.0 57.0 55.0 56.0 56.0 56.0 56.0 54.0 56.0 15:17:39 INFO - PROCESS | 3665 | 15:17:39 INFO - PROCESS | 3665 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:65.00 stddev:4.94 (7.6%) stddev-sans-first:5.19 15:17:39 INFO - PROCESS | 3665 | Values: 64.0 64.0 64.0 64.0 65.0 80.0 64.0 65.0 65.0 65.0 15:17:39 INFO - PROCESS | 3665 | 15:17:39 INFO - PROCESS | 3665 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:2.53 (3.2%) stddev-sans-first:2.55 15:17:39 INFO - PROCESS | 3665 | Values: 77.0 79.0 78.0 78.0 86.0 78.0 78.0 80.0 79.0 79.0 15:17:39 INFO - PROCESS | 3665 | 15:17:39 INFO - PROCESS | 3665 | [#11] stanford-crypto-ccm Cycles:10 Average:113.70 Median:113.50 stddev:4.24 (3.7%) stddev-sans-first:4.39 15:17:39 INFO - PROCESS | 3665 | Values: 111.0 114.0 113.0 111.0 125.0 114.0 115.0 111.0 112.0 111.0 15:17:39 INFO - PROCESS | 3665 | 15:17:39 INFO - PROCESS | 3665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.70 Median:135.00 stddev:7.73 (5.7%) stddev-sans-first:7.81 15:17:39 INFO - PROCESS | 3665 | Values: 128.0 135.0 135.0 144.0 134.0 124.0 134.0 126.0 138.0 149.0 15:17:39 INFO - PROCESS | 3665 | 15:17:39 INFO - PROCESS | 3665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 15:17:39 INFO - PROCESS | 3665 | Values: 64.0 63.0 65.0 64.0 63.0 64.0 63.0 62.0 64.0 63.0 15:17:39 INFO - PROCESS | 3665 | -------- Summary: end -------- 15:17:39 INFO - PROCESS | 3665 | 15:17:40 INFO - TEST-INFO | 3665: exit 0 15:17:40 INFO - TEST-OK | kraken | took 58845ms 15:17:40 INFO - TEST-START | v8_7 15:17:40 INFO - operating with platform_type : linux_ 15:17:40 INFO - Initialising browser for v8_7 test... 15:17:40 INFO - TEST-INFO | started process 3922 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyDLgXP/profile http://localhost:44548/getInfo.html) 15:17:44 INFO - PROCESS | 3922 | __metrics Screen width/height:1600/1200 15:17:44 INFO - PROCESS | 3922 | colorDepth:24 15:17:44 INFO - PROCESS | 3922 | Browser inner width/height: 1024/697 15:17:44 INFO - PROCESS | 3922 | __metrics 15:17:44 INFO - PROCESS | 3922 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:17:45 INFO - TEST-INFO | 3922: exit 0 15:17:45 INFO - Browser initialized. 15:17:45 INFO - Running cycle 1/1 for v8_7 test... 15:17:45 INFO - TEST-INFO | started process 4013 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyDLgXP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:17:57 INFO - PROCESS | 4013 | RSS: Main: 136843264 15:17:57 INFO - PROCESS | 4013 | 15:18:19 INFO - PROCESS | 4013 | Cycle 1(1): loaded http://localhost:44548/tests/v8_7/run.html (next: http://localhost:44548/tests/v8_7/run.html) 15:18:19 INFO - PROCESS | 4013 | RSS: Main: 414035968 15:18:19 INFO - PROCESS | 4013 | 15:18:19 INFO - PROCESS | 4013 | __start_tp_report 15:18:19 INFO - PROCESS | 4013 | _x_x_mozilla_page_load 15:18:19 INFO - PROCESS | 4013 | _x_x_mozilla_page_load_details 15:18:19 INFO - PROCESS | 4013 | |i|pagename|runs| 15:18:19 INFO - PROCESS | 4013 | |0;Richards;166.5278934221482 15:18:19 INFO - PROCESS | 4013 | |1;DeltaBlue;179.21146953405017 15:18:19 INFO - PROCESS | 4013 | |2;Encrypt;279.72027972027973 15:18:19 INFO - PROCESS | 4013 | |3;Decrypt;5240.837696335078 15:18:19 INFO - PROCESS | 4013 | |4;RayTrace;986.1932938856016 15:18:19 INFO - PROCESS | 4013 | |5;Earley;563.3802816901408 15:18:19 INFO - PROCESS | 4013 | |6;Boyer;10752.68817204301 15:18:19 INFO - PROCESS | 4013 | |7;RegExp;40620 15:18:19 INFO - PROCESS | 4013 | |8;Splay;493.33991119881597 15:18:19 INFO - PROCESS | 4013 | |9;NavierStokes;4812.5 15:18:19 INFO - PROCESS | 4013 | __end_tp_report 15:18:19 INFO - PROCESS | 4013 | __startTimestamp1457993899775__endTimestamp 15:18:19 INFO - PROCESS | 4013 | 15:18:19 INFO - PROCESS | 4013 | ------- Summary: start ------- 15:18:19 INFO - PROCESS | 4013 | Number of tests: 10 15:18:19 INFO - PROCESS | 4013 | 15:18:19 INFO - PROCESS | 4013 | [#0] Richards Cycles:1 Average:166.53 Median:166.53 stddev:0.00 (0.0%) 15:18:19 INFO - PROCESS | 4013 | Values: 166.5 15:18:19 INFO - PROCESS | 4013 | 15:18:19 INFO - PROCESS | 4013 | [#1] DeltaBlue Cycles:1 Average:179.21 Median:179.21 stddev:0.00 (0.0%) 15:18:19 INFO - PROCESS | 4013 | Values: 179.2 15:18:19 INFO - PROCESS | 4013 | 15:18:19 INFO - PROCESS | 4013 | [#2] Encrypt Cycles:1 Average:279.72 Median:279.72 stddev:0.00 (0.0%) 15:18:19 INFO - PROCESS | 4013 | Values: 279.7 15:18:19 INFO - PROCESS | 4013 | 15:18:19 INFO - PROCESS | 4013 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 15:18:19 INFO - PROCESS | 4013 | Values: 5240.8 15:18:19 INFO - PROCESS | 4013 | 15:18:19 INFO - PROCESS | 4013 | [#4] RayTrace Cycles:1 Average:986.19 Median:986.19 stddev:0.00 (0.0%) 15:18:19 INFO - PROCESS | 4013 | Values: 986.2 15:18:19 INFO - PROCESS | 4013 | 15:18:19 INFO - PROCESS | 4013 | [#5] Earley Cycles:1 Average:563.38 Median:563.38 stddev:0.00 (0.0%) 15:18:19 INFO - PROCESS | 4013 | Values: 563.4 15:18:19 INFO - PROCESS | 4013 | 15:18:19 INFO - PROCESS | 4013 | [#6] Boyer Cycles:1 Average:10752.69 Median:10752.69 stddev:0.00 (0.0%) 15:18:19 INFO - PROCESS | 4013 | Values: 10752.7 15:18:19 INFO - PROCESS | 4013 | 15:18:19 INFO - PROCESS | 4013 | [#7] RegExp Cycles:1 Average:40620.00 Median:40620.00 stddev:0.00 (0.0%) 15:18:19 INFO - PROCESS | 4013 | Values: 40620.0 15:18:19 INFO - PROCESS | 4013 | 15:18:19 INFO - PROCESS | 4013 | [#8] Splay Cycles:1 Average:493.34 Median:493.34 stddev:0.00 (0.0%) 15:18:19 INFO - PROCESS | 4013 | Values: 493.3 15:18:19 INFO - PROCESS | 4013 | 15:18:19 INFO - PROCESS | 4013 | [#9] NavierStokes Cycles:1 Average:4812.50 Median:4812.50 stddev:0.00 (0.0%) 15:18:19 INFO - PROCESS | 4013 | Values: 4812.5 15:18:19 INFO - PROCESS | 4013 | -------- Summary: end -------- 15:18:19 INFO - PROCESS | 4013 | 15:18:20 INFO - TEST-INFO | 4013: exit 0 15:18:20 INFO - TEST-OK | v8_7 | took 40199ms 15:18:20 INFO - SUITE-END | took 1211s 15:18:20 INFO - Completed test suite (00:20:11) 15:18:20 INFO - Working with test: dromaeo_css 15:18:20 INFO - Generating results file: dromaeo_css 15:18:20 INFO - Working with test: kraken 15:18:20 INFO - Generating results file: kraken 15:18:20 INFO - javascript benchmark 15:18:20 INFO - Working with test: v8_7 15:18:20 INFO - Generating results file: v8_7 15:18:20 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:18:20 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 15:18:20 INFO - process_Request line: dromaeo_css 7325.11 graph.html#tests=[[72,53,35]] 15:18:20 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:18:21 INFO - process_Request line: kraken 1475.00 graph.html#tests=[[232,53,35]] 15:18:21 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:18:21 INFO - process_Request line: v8_7 21872.54 graph.html#tests=[[230,53,35]] 15:18:21 INFO - RETURN: dromaeo_css: 7325.11 15:18:21 INFO - RETURN: kraken: 1475.00 15:18:21 INFO - RETURN: v8_7: 21872.54 15:18:21 INFO - javascript benchmark 15:18:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3288.4409650359435, 3324.484704870746, 3341.264921717223, 3346.314005628846, 3369.0903456066862, 5338.172583249598, 5364.758585863636, 5365.651232669874, 5382.596305277105, 5396.514313711765, 5362.2224777407255, 5376.166694162402, 5394.703291318976, 5404.189371594262, 5411.377691565471, 4860.368152140217, 4904.583110435608, 4912.926306105412, 4951.405831300249, 4975.751212439363, 4887.486813884544, 4922.483139270379, 4960.975195124038, 4988.226824842155, 4990.625703072266, 4923.359963204778, 4995.5753760930365, 5003.249512573125, 5009.348784657989, 5026.371703537058, 4835.468098509161, 4925.21196608541, 4939.728314942677, 4954.2568614707725, 4961.9751901240625, 4799.568038876483, 4825.227963525819, 4874.731889746063, 4894.388201474816, 4906.681065730716, 5273.578113750891, 5282.31329927107, 5285.973570132163, 5291.074062039128, 5337.893242135175, 5765.88468230633, 5803.47768700819, 5816.1566572846705, 5818.127280907897, 5823.068309070571, 5726.255586773735, 5785.421457854223, 5792.565557583198, 5812.215350927613, 5834.124881267801, 5437.184422336682, 5475.178723191513, 5481.095619222823, 5485.122380419114, 5495.587830912697, 5958.433948774859, 5968.955432799243, 5969.343372229051, 5969.73136208863, 5971.984762590283, 5605.271314729059, 5703.657780533182, 5704.486596206361, 5742.7702891883855, 5781.53747700183, 5755.1367294906095, 5757.65454072757, 5762.88474230513, 5773.076307790733, 5807.651540907559, 5697.6296540724725, 5719.942800572025, 5732.656040637575, 5742.109972954198, 5745.052066408995, 5539.446055394428, 5597.44025597437, 5650.237217975603, 5713.05734553794, 5769.769209231667, 4450.955490445054, 4456.554344565518, 4463.5313292103865, 4471.932921006188, 4485.596296333346, 4015.8795236142964, 4031.677465802729, 4032.052467670095, 4046.3121269384274, 4059.837606495766, 5375.704336261465, 5383.515483606416, 5437.483439073281, 5448.509634132947, 5487.890242195133, 5782.103773914966, 5809.970950145223, 5826.475617194473, 5838.503727183237, 5845.912311315334, 5408.080626293539, 5423.728813559306, 5427.891442171213, 5449.6730196188355, 5452.672839629635, 4903.926441103386, 4949.059678661043, 4989.12690279207, 5039.77321020555, 5045.697258164522, 5795.449432303924, 5801.506871915934, 5801.7099145042575, 5808.5062769665055, 5810.244668193108, 5673.0639444492845, 5693.715314234355, 5702.515286200553, 5707.714614269353, 5719.885602287848, 5750.30996280449, 5835.56233282497, 5866.472017518273, 5885.705714714333, 5896.439838215363, 5592.245046918614, 5630.577706671934, 5637.49262566371, 5638.379778224474, 5639.407862174413, 5668.461496157858, 5706.800261990977, 5707.5433965281845, 5709.314882214161, 5710.057840456278, 5548.722563871871, 5578.30271216098, 5634.1267103597365, 5637.2107904894165, 5643.830685079454, 5647.124695672177, 5666.093425051972, 5678.630888992202, 5684.431556844283, 5692.886142277214, 5378.40837507866, 5495.53287970527, 5583.804566840141, 5588.357338905916, 5590.776368945197, 5666.065099258576, 5730.312362516524, 5742.655440673573, 5743.7989670363, 5769.567282453749, 5538.501534861882, 5580.916286255629, 5585.888282234251, 5589.888202236014, 5602.635828671123], "unit": "score", "name": "dojo.html", "value": 5326.163519708073}, {"lowerIsBetter": false, "replicates": [527.1118165890475, 548.6817645765456, 560.4619565217391, 580.7183515994742, 592.2508027345409, 31689.207769805766, 38720.61279387205, 39304.41043384344, 39331.80334098333, 39370.40944385833, 42097.57902420975, 42349.576504234945, 42376.36435453463, 42559.78720106403, 42645.0, 8790.956045219766, 8985.550722463851, 8988.505632190227, 8989.640414383417, 8991.910080899206, 8740.694075707352, 8870.112988701143, 8881.111888811132, 8886.155815197546, 9150.084991500864, 9148.588313525906, 9163.129502697266, 9189.954050229739, 9241.49171795551, 9243.53782310885, 9094.181523662868, 9103.63585456581, 9143.13140251675, 9160.404573702688, 9181.816363672722, 8981.326400519987, 9095.63617455301, 9116.179543841086, 9119.088091190893, 9122.954385228031, 42401.0, 42796.144077118595, 42867.0, 42884.78557607223, 42917.0, 3551.396262635358, 3597.6582224688614, 3658.847463049158, 3716.7026637868908, 3864.3237433449317, 29492.26269343262, 30644.84677576598, 30900.69099309023, 31136.065918022494, 31734.365312693615, 3892.2215556888737, 3997.6801855851754, 4312.266914624522, 4364.978175109136, 4400.44994375703, 238903.0, 241591.0, 242598.0, 426663.0, 431003.84498077625, 69603.0, 70329.64835175792, 70515.2948470519, 70904.64547677229, 70955.64522177356, 60368.0, 60405.39594604086, 60517.0, 60575.0, 60597.0, 18334.449966501026, 18587.44237672872, 18621.44135675932, 18740.531486712942, 18786.436406907815, 14688.632784180481, 14766.187859667607, 14819.703605928036, 14832.851671483362, 14864.62838429048, 21777.673334899988, 21976.45058873509, 22220.444488887584, 22252.22117225922, 22275.55448891013, 8269.917300827035, 8638.95680521606, 8731.345149113842, 8780.78048048791, 8834.55827208637, 1022.3150489172273, 1036.4817591204398, 1103.150574057987, 1147.2370873369116, 1212.2181193130382, 32048.0, 33743.66256337454, 34442.0, 34777.0, 34799.65200348015, 1123.9381833999046, 1125.6679279612533, 1127.8590176227972, 1150.6950658075616, 1154.7921374152565, 14430.567082987527, 15147.848521514865, 15545.22273886301, 15884.76172857408, 16632.0, 446635.0, 450926.0, 451534.0, 453066.0, 453361.0, 58147.0, 58730.0, 58754.118688219714, 58769.0, 58812.0, 1313.8620444853343, 1412.5968171743123, 1473.992630036843, 1494.8280947690937, 1514.0158896717003, 29577.0, 29912.0, 34544.654553454144, 35067.12332191614, 35640.82179589086, 48342.0, 55611.0, 56577.43422565722, 56646.43353566576, 56647.433525664215, 310881.0, 442777.0, 448019.0, 449022.0, 451141.0, 40749.38875916805, 41236.79381603073, 41314.0, 41459.0, 45354.319685204086, 49840.0, 49920.50079499158, 50176.749116254185, 50406.747966259936, 50558.241626376366, 40640.39039414352, 42170.36744448775, 42682.1463570733, 42771.7861410691, 43571.0, 41683.58316416797, 42038.57961420469, 42347.7882610585, 42899.78550107229, 43016.0, 41609.79195104005, 41942.16115677731, 42213.0, 42251.57748422476, 42403.575964239964, 36099.0, 37020.62979370279, 37373.43939840959, 38174.23651526898, 38383.0, 25212.0, 28081.937054649723, 28441.288967775145, 28827.279318017216, 30571.847140764155], "unit": "score", "name": "ext.html", "value": 20741.593868434553}, {"lowerIsBetter": false, "replicates": [382.4760078692192, 387.0729602601769, 389.1458249143132, 392.5475739762878, 393.0547034382312, 14481.63795905103, 15106.395744170248, 16639.584010399733, 19007.61984760304, 19010.90494547527, 18202.271909123618, 18341.0, 18647.440576782683, 18692.906535467337, 18950.147243374046, 5930.0, 6103.908441373383, 6118.908216376758, 6125.724342404603, 6140.600860944047, 4535.365048893158, 4662.417197850269, 4703.6237101032, 6142.201513803199, 6200.3179650238435, 6536.93463065368, 6883.3116688331265, 6903.861922761542, 6914.688839002257, 6919.688614012382, 6618.768343107968, 6867.244603093655, 6907.481938854581, 6910.239873613898, 6920.411764999981, 6529.673516324212, 6536.9673151634415, 6537.280899101095, 6539.738410463576, 6573.539852210347, 21529.354119376443, 21693.783062169336, 21980.670289945505, 21995.560088798135, 22381.0, 2420.4432980414426, 2464.5933420985516, 2516.3960649444, 2559.5776696845182, 2609.6216048673027, 9998.300118991674, 14174.362153703109, 14196.645083872883, 14196.645083872985, 14470.42118315266, 1940.417874637603, 1941.4855063408208, 1943.9708404373805, 1962.0, 1973.9703904441444, 58203.41796582023, 59397.10904336481, 60475.09287360693, 60700.0, 61205.38794612041, 10867.83698244527, 10895.564177432972, 10896.073833724064, 10930.672079837617, 10940.945295273632, 13745.862541374458, 13849.723005539832, 13954.232517211447, 13970.650733731534, 13988.440462381594, 8497.660093596187, 8575.056743758181, 8645.351598630128, 8675.869861952076, 8765.211130998114, 7844.058712954482, 8073.798155046171, 8320.83358332842, 8633.309335253165, 8693.521856297837, 4443.533428989909, 4642.326862604903, 4830.686005409637, 4861.975690121527, 4991.47589503097, 1908.3034692337196, 1948.1622902151928, 1971.5366888781125, 1987.9105440255223, 2006.5585571174317, 949.7578117579973, 977.1791694976254, 1025.99487002566, 1059.7191744187796, 1078.6516853932585, 17247.56881077958, 17398.21708023142, 17859.910700446413, 18067.0, 18146.818531814777, 989.6981420666766, 1032.4321623107412, 1045.7124290820086, 1090.2041509697965, 1094.8357746338113, 9318.48748318849, 9815.0, 9840.212782977345, 9843.458609776531, 9865.852012219822, 545734.0, 551702.0, 553484.0, 596778.0, 599380.0, 71820.0, 73619.0, 75949.24050759533, 76283.61858190673, 77406.6129669348, 1202.8135638975973, 1238.2508582307573, 1247.5820600099069, 1255.704909346321, 1266.094742259289, 15124.848751512343, 16082.517524474284, 16193.271302791638, 16384.672306553563, 16469.91765041215, 32696.182595435304, 32923.17692057718, 33075.50386744249, 33760.49359259662, 36704.63295367012, 43592.34611480894, 45132.09735805331, 45441.54558454373, 46532.0, 49245.261321079495, 7593.1647518774, 7754.108277548155, 7798.610069496389, 7885.723999659985, 8064.677412903653, 9983.15143212835, 11048.779024419628, 11127.0, 11183.993440590386, 11871.76256474883, 5319.59030856831, 9470.289728270269, 9733.415995040321, 9929.801403971736, 9958.402495850272, 9886.406815591088, 10688.83966740484, 10837.241393102408, 10903.672889813319, 11227.045701115496, 7428.33145016951, 7594.848103038019, 7868.252516011199, 8048.356131509582, 10020.749481263027, 10116.412690482139, 10286.845697314397, 10806.459677016275, 10858.294210876267, 10967.23229373968, 8698.826023479369, 10395.116415104801, 10455.843162352723, 10488.26582139243, 10760.515776789907], "unit": "score", "name": "jquery.html", "value": 8952.972147708873}, {"lowerIsBetter": false, "replicates": [1427.1651084115792, 1563.8905276630637, 1580.699667063258, 1811.7101263797795, 1938.8158124978122, 7214.567125972439, 7742.070951485823, 7891.250331218539, 7926.167752386003, 7931.9206807931905, 7746.0, 7897.249761272684, 7898.289153976141, 7929.801754956129, 7931.206879312066, 2424.236365544852, 2437.81716371272, 2445.76765207305, 2448.033026954352, 2450.7304196538366, 2384.880755962195, 2406.193925035115, 2449.9387515312083, 2450.7181674107437, 2471.9258422247362, 2437.0251899240357, 2439.4389290463205, 2451.4974430241846, 2463.987680061597, 2469.074097213545, 2353.352827972304, 2384.3562238195764, 2399.568077745996, 2402.1952645863657, 2407.9036838526526, 2347.354477518696, 2403.795677367426, 2407.0853075831246, 2411.9155829546057, 2412.1798588479824, 7050.153981522199, 7200.423966082701, 8102.878456823152, 8152.714654987106, 8153.796155096111, 4899.55903968641, 4933.062718083588, 4977.576905962997, 4986.87532811679, 4996.90006199874, 3247.691469310412, 3254.4142054430195, 3260.951085733716, 3312.4368857294317, 3344.7156991655497, 1029.1201023125195, 1049.7008352619544, 1051.4900273367412, 1071.1698433713934, 1077.7251800790748, 10676.199285053652, 10784.892151078468, 10786.0, 11096.167787415976, 11097.722556936142, 4437.29003359461, 4473.3960915276675, 4489.057297967398, 4516.209663308908, 4520.728756274634, 9591.376560523544, 9593.328467007383, 9595.23238140947, 9597.712068637951, 9605.903940960641, 4969.726665033386, 4995.475475075137, 5005.174146265826, 5005.774740136702, 5005.849824505271, 4562.452505699271, 4573.085382923428, 4579.335996280587, 4581.106684196617, 4581.198290299184, 3796.7532110412735, 3821.3694740367528, 3827.827747751358, 3875.0, 3885.106425522146, 1223.3760782001243, 1246.5761641041909, 1247.002398081531, 1253.6051143889645, 1256.1458208418362, 1415.5611760354323, 1416.362636813438, 1432.6633241188313, 1440.7118576284786, 1447.4933773179514, 7706.691732330756, 7709.460337776414, 7762.340201082859, 7763.92236077632, 7773.650185741655, 520.4353276694828, 535.2987586262009, 536.4742552298691, 537.2746791830997, 539.9730013499309, 5750.396208398141, 5906.8818623627285, 5963.970180149158, 5968.791092311748, 5972.671503067373, 9115.134062264075, 9591.136797688241, 9614.95192524033, 9727.221822254203, 9766.853497197548, 9503.429794212369, 9530.142287194185, 9599.712008639752, 9645.421274723398, 10025.649102281384, 7808.492447990976, 7812.843743125106, 7813.296803287618, 7913.089994650573, 7913.604319783988, 7754.88367674474, 7764.107127680163, 7831.84336313282, 7852.960735196288, 7855.5286682799215, 8762.430442021503, 8817.589185730252, 8915.331350148635, 8990.640374384951, 9122.589483473392, 9089.954550227207, 9096.363254572116, 9105.77235569116, 9241.907580924104, 9257.67598134062, 7398.667059982206, 7449.702011919462, 7453.105627324756, 7459.962700186681, 7471.103467583925, 7694.07671079474, 7970.561619111005, 7976.92023079785, 7986.041674999037, 7989.840203195788, 7514.549127052394, 7636.847263054597, 7644.541327520366, 7668.348190403655, 7733.033370828646, 7486.588237646982, 7502.662380193014, 7508.511946723445, 7516.8496630066, 7558.962205188939, 7541.208173141741, 7707.730229441942, 7711.691532338644, 7713.922860771545, 7718.3053525183, 7052.400545953446, 7097.716091356495, 7105.147382314155, 7151.749688760869, 7172.748953786592, 6791.864162716619, 6916.654167291515, 6937.618430986344, 6940.722371105099, 7154.928450715634], "unit": "score", "name": "mootools.html", "value": 4665.780381025002}, {"lowerIsBetter": false, "replicates": [345.7320576553171, 352.99999999999994, 364.1914948813636, 364.9945250821238, 371.1482148469263, 6050.2437195350585, 6076.665783381913, 6087.086936959453, 6090.725917333725, 6115.663638499881, 5709.914351284734, 5824.242848429709, 5830.096335068071, 5968.164456976016, 5998.370171132034, 4723.126221649006, 4732.976335118319, 4754.786034628432, 4757.096151731177, 4764.475907650156, 4515.096980603876, 4747.881302967419, 4752.263399173134, 4755.239161734124, 4758.214894542413, 4550.453945526541, 4591.104734576759, 4697.17799385108, 4702.05958808238, 4702.952970470285, 4677.789499472532, 4686.297055441677, 4692.507286734912, 4696.718196908162, 4705.200115980291, 4167.770772607505, 4172.415861779354, 4177.498700156001, 4179.331306990897, 4180.143070670505, 5562.7774889004395, 5738.770449182028, 5745.6552606843725, 5746.281714785652, 5746.597738158331, 5349.43830897754, 5382.703951282678, 5421.1597202433295, 5423.891522169574, 5424.538914192299, 6411.87176256477, 6416.967915160441, 6418.454431373339, 6420.93579064208, 6422.068800023971, 4517.457905051382, 4518.683692141552, 4522.570355816225, 4525.570070843265, 4532.4787649420405, 6558.540902136852, 6613.966930165367, 6662.933370666328, 6663.500237482208, 6674.966625166843, 4658.906821863611, 4658.95341046592, 4660.4174478190225, 4661.974365639554, 4667.836625718083, 4722.858314250578, 4724.4094488188975, 4725.480197178307, 4728.881777955578, 4730.668853180313, 5407.242985981966, 5414.648047876875, 5415.268938693226, 5420.0, 5420.430854760193, 6305.905411418832, 6443.29123796382, 6443.326019701772, 6450.096986421905, 6454.741810327534, 1636.5663099278702, 1662.4098445052075, 1663.4011755767913, 1664.9167541622871, 1665.6335606166624, 1120.6750042487588, 1132.9943350283195, 1135.3074624479061, 1149.7642983188425, 1150.5052827284348, 6195.690215489208, 6202.28673702521, 6209.96895015531, 6211.503079753609, 6211.813645590549, 6417.839554011093, 6643.534952553275, 6651.301613330627, 6659.833504162435, 6664.500162487833, 6108.389161083945, 6137.864495068427, 6237.126802247689, 6249.6562689052535, 6252.218472690914, 3558.323918455537, 3606.945895811565, 3608.7473876828894, 3610.8736194233074, 3611.5124458198334, 6728.529002969745, 6856.725730970805, 6860.108185935796, 6868.450523958071, 6870.141232345957, 6820.454363650896, 6825.249222585511, 6829.146356705412, 6831.59010459374, 6832.6925288362145, 6825.69284382204, 6838.384545390939, 6845.657717114124, 6848.0, 6857.348551887562, 6578.671066446755, 6689.933100668931, 6690.83272918181, 6691.498137639794, 6691.966540167268, 6579.144711187707, 6580.539362244788, 6582.736690532517, 6582.901256481253, 6587.538872279086, 6851.07510486078, 6858.3827455529245, 6862.210845752603, 6863.0, 6865.588064716133, 4485.6860019798305, 4606.585407313358, 4609.4699109602825, 4613.377194078891, 4615.561521655437, 6666.100076489612, 6668.066470694203, 6674.499412543982, 6682.131322927989, 6682.699278532575, 6504.0, 6511.837204069936, 6529.575577587441, 6595.241547222131, 6597.736090556324, 6377.649229292433, 6493.707783149675, 6497.675116244074, 6503.934960650522, 6510.0, 6377.808665740035, 6385.8722825544155, 6386.904196436964, 6395.840103997437, 6396.872062558816, 6541.247756508063, 6553.082568440517, 6555.836104097436, 6609.900851487136, 6616.106825578485, 6288.434040936338, 6303.275123360872, 6373.553851230369, 6386.648734319657, 6393.680315984275], "unit": "score", "name": "prototype.html", "value": 4896.401751917293}, {"lowerIsBetter": false, "replicates": [783.6003638144545, 838.1827717974975, 893.8703887936249, 898.9505577193255, 914.4376208631694, 14544.0, 14569.12585244886, 14675.266236688176, 14721.926390368046, 14743.70512589749, 14028.789568156486, 14059.929700351484, 14083.507077252298, 14126.78809817851, 14161.50434734782, 753.2580408297822, 767.5816679909462, 892.8883889513794, 900.9729708108767, 927.3091546797646, 905.6649039855263, 905.959231834569, 907.5054095517959, 911.1526280559077, 914.8764916736222, 967.7048500207434, 967.7435479597913, 968.8934217236099, 970.8883478399969, 971.4365667912629, 794.2454668065332, 804.2199066905092, 945.394947233771, 960.2414092866627, 973.2214228617078, 717.2648035763384, 717.8205448637841, 718.532953580177, 718.8777907755695, 718.9928100718978, 14249.928750356183, 14273.714525709427, 14298.28508574567, 14319.498817541336, 14322.713545729132, 13560.59318220455, 13933.721325573431, 13975.65060873476, 14095.78856317156, 14117.858821411757, 11438.885611143949, 11522.827157592643, 11554.94222528882, 11582.94208528952, 11683.240589361749, 3910.7849068301234, 3913.6477717005605, 3926.2147570486018, 3981.542122655903, 4023.959760402417, 50251.24623130619, 51685.483145168444, 52145.47854521482, 52174.0, 52312.47687523152, 10861.945690271497, 10881.673549793519, 10901.0, 11001.394923279297, 11124.55501779936, 19129.0, 19169.233230670896, 19404.0, 19411.805881941284, 19418.902905485666, 8145.266925976691, 8311.750647480585, 8410.243078122998, 8432.831343373098, 8469.745907622659, 4614.930776038362, 4626.190416677068, 4628.976855115703, 4636.420447444069, 4689.390379250675, 3275.934481310408, 3311.403947289463, 3312.0560640217423, 3312.635610082889, 3314.8674053037607, 568.3549171690079, 587.6356658871528, 591.1782622155208, 594.432317137133, 602.8161410769758, 521.5254118751993, 593.6883136353449, 685.4345165238698, 705.5519744961883, 708.3058602569511, 8426.325893928471, 9215.354925155309, 9253.0, 9901.40591564494, 9984.500774961223, 592.7688201601379, 619.3775255867824, 653.7646447278976, 702.6556987076398, 778.1328780991263, 4044.3933409988736, 4490.326451032306, 4538.636909047268, 4550.2492088804975, 4632.420947381577, 60818.0, 63088.0, 63206.683966579876, 63239.36760632427, 63309.68345158337, 52917.47082529125, 53921.0, 54738.0, 55171.0, 55693.164602531, 50233.497665022885, 50552.0, 50811.0, 50946.74526627343, 51051.0, 9650.469224192737, 9667.226621870093, 9857.457839818879, 9931.106200441995, 10039.548220329956, 35421.291574168885, 35803.82098089493, 36545.0, 36637.63362366342, 36902.0, 44589.0, 48215.5178448211, 48476.5152348472, 51228.0, 52720.472795271555, 12381.814272785736, 12570.748585028432, 12623.242605443702, 12627.052971027026, 12927.676808079874, 13430.798538021741, 13762.449502019806, 13777.448902043807, 13873.0, 14009.0, 11594.594189203337, 12346.3826808661, 12384.195027323196, 12486.875131248571, 12672.619821405373, 11621.360825154698, 11759.235649682743, 11780.587679431179, 12046.216995895238, 12346.320952347347, 11399.0, 11925.165238433226, 11952.342621155572, 11961.401929903295, 12127.939360303142, 9431.669891553762, 9596.328257021942, 9722.465264410524, 10062.547185376821, 10314.329568578018, 10478.94760526223, 10787.0, 10839.458027098455, 10867.0, 10885.945570272099], "unit": "score", "name": "yui.html", "value": 6836.293309213283}], "name": "dromaeo_css", "value": 7325.114291344299}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 107.0, 110.0, 110.0, 109.0, 98.0, 110.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.7}, {"lowerIsBetter": true, "replicates": [146.0, 131.0, 160.0, 168.0, 124.0, 151.0, 150.0, 125.0, 158.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 161.0, 160.0, 159.0, 162.0, 160.0, 162.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 74.0, 156.0, 76.0, 74.0, 72.0, 73.0, 145.0, 77.0], "unit": "score", "name": "audio-fft", "value": 89.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 139.0, 95.0, 95.0, 96.0, 145.0, 95.0, 95.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 147.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 57.0, 55.0, 56.0, 56.0, 56.0, 56.0, 54.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 56.0}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 80.0, 64.0, 65.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.0}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 78.0, 78.0, 86.0, 78.0, 78.0, 80.0, 79.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.2}, {"lowerIsBetter": true, "replicates": [111.0, 114.0, 113.0, 111.0, 125.0, 114.0, 115.0, 111.0, 112.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.7}, {"lowerIsBetter": true, "replicates": [128.0, 135.0, 135.0, 144.0, 134.0, 124.0, 134.0, 126.0, 138.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.7}, {"lowerIsBetter": true, "replicates": [64.0, 63.0, 65.0, 64.0, 63.0, 64.0, 63.0, 62.0, 64.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 63.5}], "name": "kraken", "value": 1475.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.5278934221482], "unit": "score", "name": "Richards", "value": 211.98851000000005}, {"lowerIsBetter": false, "replicates": [179.21146953405017], "unit": "score", "name": "DeltaBlue", "value": 368.93844}, {"lowerIsBetter": false, "replicates": [279.72027972027973], "unit": "score", "name": "Encrypt", "value": 951.5970750000004}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [986.1932938856016], "unit": "score", "name": "RayTrace", "value": 750.3488460000001}, {"lowerIsBetter": false, "replicates": [563.3802816901408], "unit": "score", "name": "Earley", "value": 1182.9718249999999}, {"lowerIsBetter": false, "replicates": [10752.68817204301], "unit": "score", "name": "Boyer", "value": 61.98105900000006}, {"lowerIsBetter": false, "replicates": [40620.0], "unit": "score", "name": "RegExp", "value": 22.427006400787796}, {"lowerIsBetter": false, "replicates": [493.33991119881597], "unit": "score", "name": "Splay", "value": 165.182257}, {"lowerIsBetter": false, "replicates": [4812.5], "unit": "score", "name": "NavierStokes", "value": 308.3636363636364}], "name": "v8_7", "value": 21872.539908915795}]} 15:18:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "21872.54"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1475.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7325.11"}}} 15:18:21 INFO - Return code: 0 15:18:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:18:21 INFO - # TBPL SUCCESS # 15:18:21 INFO - Running post-action listener: _resource_record_post_action 15:18:21 INFO - Running post-run listener: _resource_record_post_run 15:18:22 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 7938048; Write bytes: 364208128; Read time: 2704; Write time: 247668 15:18:22 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 4624384; Read time: 0; Write time: 292 15:18:22 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 6176768; Write bytes: 359583744; Read time: 2668; Write time: 247376 15:18:22 INFO - Running post-run listener: _upload_blobber_files 15:18:22 INFO - Blob upload gear active. 15:18:22 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 15:18:22 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 15:18:22 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', 'Mozilla-Beta', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 15:18:22 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 Mozilla-Beta -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 15:18:22 INFO - (blobuploader) - INFO - Open directory for files ... 15:18:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:18:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:18:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:18:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:18:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:18:23 INFO - (blobuploader) - INFO - Done attempting. 15:18:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 15:18:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:18:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:18:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:18:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:18:24 INFO - (blobuploader) - INFO - Done attempting. 15:18:24 INFO - (blobuploader) - INFO - Iteration through files over. 15:18:24 INFO - Return code: 0 15:18:24 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 15:18:24 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 15:18:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3141a6a3eaeca8cefb910d706220759c6c642e29b82dd83d0916ca1b9c0caf2ed99f6ee2d2de7c1c6c6a7a2783a452f7dd3675c0ab32b06a431ba88386bf602", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e95061bb0e3bf9137aaa5b8fc631951e5217ff9011725cd2e283bceea6df9165c56eb6e4c9cb36359921dafad31dda3907b76ada947bc012be8cb438e11b03af"} 15:18:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 15:18:24 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 15:18:24 INFO - Contents: 15:18:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3141a6a3eaeca8cefb910d706220759c6c642e29b82dd83d0916ca1b9c0caf2ed99f6ee2d2de7c1c6c6a7a2783a452f7dd3675c0ab32b06a431ba88386bf602", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e95061bb0e3bf9137aaa5b8fc631951e5217ff9011725cd2e283bceea6df9165c56eb6e4c9cb36359921dafad31dda3907b76ada947bc012be8cb438e11b03af"} 15:18:24 INFO - Running post-run listener: copy_logs_to_upload_dir 15:18:24 INFO - Copying logs to upload dir... 15:18:24 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 15:18:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.330445 ========= master_lag: 0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-03-14 15:18:24.472222) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 15:18:24.475652) ========= 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=41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3141a6a3eaeca8cefb910d706220759c6c642e29b82dd83d0916ca1b9c0caf2ed99f6ee2d2de7c1c6c6a7a2783a452f7dd3675c0ab32b06a431ba88386bf602", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e95061bb0e3bf9137aaa5b8fc631951e5217ff9011725cd2e283bceea6df9165c56eb6e4c9cb36359921dafad31dda3907b76ada947bc012be8cb438e11b03af"} build_url:https://queue.taskcluster.net/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011315 build_url: 'https://queue.taskcluster.net/v1/task/Rn7huqHvTLmvPjUb60ihnA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a3141a6a3eaeca8cefb910d706220759c6c642e29b82dd83d0916ca1b9c0caf2ed99f6ee2d2de7c1c6c6a7a2783a452f7dd3675c0ab32b06a431ba88386bf602", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e95061bb0e3bf9137aaa5b8fc631951e5217ff9011725cd2e283bceea6df9165c56eb6e4c9cb36359921dafad31dda3907b76ada947bc012be8cb438e11b03af"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 15:18:24.500891) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 15:18:24.501230) ========= 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=41bf3e9aed84707956354da8000001c5-1457992391.816764-682084111 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004401 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 15:18:24.585978) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 15:18:24.586300) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 15:18:24.586576) ========= ========= Total master_lag: 0.41 =========