builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-044 starttime: 1457992891.12 results: success (0) buildid: 20160314121843 builduid: 330a89ceab5e4eb59b479cc2f2583e80 revision: cd9a385c536ce27831ff580e4a41d2f16e73d18a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:31.124423) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:31.125013) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:31.125354) ========= 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=574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006402 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:31.154528) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:31.154912) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:31.169707) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:31.170376) ========= 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=574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004597 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:31.235042) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:31.235400) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:31.236004) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:31.236326) ========= 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=574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-14 15:01:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.9M=0s 2016-03-14 15:01:31 (36.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.156233 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:31.411170) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:31.411490) ========= 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=574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015326 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:31.469252) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:31.470072) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev cd9a385c536ce27831ff580e4a41d2f16e73d18a --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 cd9a385c536ce27831ff580e4a41d2f16e73d18a --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=574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-14 15:01:31,560 truncating revision to first 12 chars 2016-03-14 15:01:31,560 Setting DEBUG logging. 2016-03-14 15:01:31,560 attempt 1/10 2016-03-14 15:01:31,560 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/cd9a385c536c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-14 15:01:31,852 unpacking tar archive at: mozilla-beta-cd9a385c536c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.587845 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:32.076023) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:32.076871) ========= echo cd9a385c536ce27831ff580e4a41d2f16e73d18a in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'cd9a385c536ce27831ff580e4a41d2f16e73d18a'] 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=574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False cd9a385c536ce27831ff580e4a41d2f16e73d18a program finished with exit code 0 elapsedTime=0.004813 script_repo_revision: 'cd9a385c536ce27831ff580e4a41d2f16e73d18a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:32.133898) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:32.134586) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-14 15:01:32.145548) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-14 15:01:32.146249) ========= /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=574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:01:32 INFO - MultiFileLogger online at 20160314 15:01:32 in /builds/slave/test-pgo 15:01:32 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 15:01:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:01:32 INFO - {'append_to_log': False, 15:01:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:01:32 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:01:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:01:32 INFO - 'branch': 'Mozilla-Beta', 15:01:32 INFO - 'buildbot_json_path': 'buildprops.json', 15:01:32 INFO - 'config_files': ('talos/linux_config.py',), 15:01:32 INFO - 'default_actions': ('clobber', 15:01:32 INFO - 'read-buildbot-config', 15:01:32 INFO - 'download-and-extract', 15:01:32 INFO - 'populate-webroot', 15:01:32 INFO - 'create-virtualenv', 15:01:32 INFO - 'install', 15:01:32 INFO - 'run-tests'), 15:01:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:01:32 INFO - 'download_minidump_stackwalk': True, 15:01:32 INFO - 'download_symbols': 'ondemand', 15:01:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:01:32 INFO - 'tooltool.py': '/tools/tooltool.py', 15:01:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:01:32 INFO - '/tools/misc-python/virtualenv.py')}, 15:01:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:01:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:01:32 INFO - 'installer_path': 'installer.exe', 15:01:32 INFO - 'log_level': 'info', 15:01:32 INFO - 'log_name': 'talos', 15:01:32 INFO - 'log_to_console': True, 15:01:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:01:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:01:32 INFO - 'opt_config_files': (), 15:01:32 INFO - 'pip_index': False, 15:01:32 INFO - 'sps_profile': False, 15:01:32 INFO - 'sps_profile_interval': 0, 15:01:32 INFO - 'suite': 'dromaeojs', 15:01:32 INFO - 'system_bits': '32', 15:01:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:01:32 INFO - 'title': 'talos-linux64-ix-044', 15:01:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:01:32 INFO - 'use_talos_json': True, 15:01:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:01:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:01:32 INFO - 'work_dir': 'build'} 15:01:32 INFO - ##### 15:01:32 INFO - ##### Running clobber step. 15:01:32 INFO - ##### 15:01:32 INFO - Running pre-action listener: _resource_record_pre_action 15:01:32 INFO - Running main action method: clobber 15:01:32 INFO - rmtree: /builds/slave/test-pgo/build 15:01:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:01:32 INFO - Running post-action listener: _resource_record_post_action 15:01:32 INFO - ##### 15:01:32 INFO - ##### Running read-buildbot-config step. 15:01:32 INFO - ##### 15:01:32 INFO - Running pre-action listener: _resource_record_pre_action 15:01:32 INFO - Running main action method: read_buildbot_config 15:01:32 INFO - Using buildbot properties: 15:01:32 INFO - { 15:01:32 INFO - "project": "", 15:01:32 INFO - "product": "firefox", 15:01:32 INFO - "script_repo_revision": "production", 15:01:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 15:01:32 INFO - "repository": "", 15:01:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 15:01:32 INFO - "buildid": "20160314121843", 15:01:32 INFO - "pgo_build": "True", 15:01:32 INFO - "basedir": "/builds/slave/test-pgo", 15:01:32 INFO - "buildnumber": 151, 15:01:32 INFO - "slavename": "talos-linux64-ix-044", 15:01:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:01:32 INFO - "platform": "ubuntu64_hw", 15:01:32 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:01:32 INFO - "branch": "mozilla-beta", 15:01:32 INFO - "repo_path": "releases/mozilla-beta", 15:01:32 INFO - "revision": "cd9a385c536ce27831ff580e4a41d2f16e73d18a", 15:01:32 INFO - "stage_platform": "linux64-pgo", 15:01:32 INFO - "builduid": "330a89ceab5e4eb59b479cc2f2583e80", 15:01:32 INFO - "slavebuilddir": "test" 15:01:32 INFO - } 15:01:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 15:01:32 INFO - Running post-action listener: _resource_record_post_action 15:01:32 INFO - ##### 15:01:32 INFO - ##### Running download-and-extract step. 15:01:32 INFO - ##### 15:01:32 INFO - Running pre-action listener: _resource_record_pre_action 15:01:32 INFO - Running main action method: download_and_extract 15:01:32 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:01: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')]} 15:01:32 INFO - https://queue.taskcluster.net/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:01:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/test_packages.json 15:01:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/test_packages.json 15:01:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:01:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:01:33 INFO - Downloaded 1412 bytes. 15:01:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:01:33 INFO - Using the following test package requirements: 15:01:33 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 15:01:33 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 15:01:33 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:01:33 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 15:01:33 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 15:01:33 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 15:01:33 INFO - u'jsshell-linux-x86_64.zip'], 15:01:33 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 15:01:33 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:01:33 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 15:01:33 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 15:01:33 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 15:01:33 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 15:01:33 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 15:01:33 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 15:01:33 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:01:33 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 15:01:33 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 15:01:33 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:01:33 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:01:33 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')]} 15:01:33 INFO - https://queue.taskcluster.net/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:01:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 15:01:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 15:01:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/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 15:01:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/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 15:01:34 INFO - Downloaded 23104406 bytes. 15:01:34 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'] 15:01:34 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 15:01:35 INFO - Return code: 0 15:01:35 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 15:01:35 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')]} 15:01:35 INFO - https://queue.taskcluster.net/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:01:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 15:01:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 15:01:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/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 15:01:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/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 15:01:37 INFO - Downloaded 23104406 bytes. 15:01:37 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'] 15:01:37 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 15:01:38 INFO - Return code: 0 15:01:38 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')]} 15:01:38 INFO - https://queue.taskcluster.net/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:01:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 15:01:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 15:01:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/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 15:01:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/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 15:01:39 INFO - Downloaded 10801536 bytes. 15:01:39 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'] 15:01:39 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 15:01:40 INFO - Return code: 0 15:01:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:40 INFO - https://queue.taskcluster.net/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:01:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 15:01:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 15:01:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/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 15:01:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/V2cj4JNvQpOEHfT-iru2tg/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 15:01:41 INFO - Downloaded 52852977 bytes. 15:01:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 15:01:41 INFO - mkdir: /builds/slave/test-pgo/properties 15:01:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:01:41 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:01:41 INFO - Contents: 15:01:41 INFO - build_url:https://queue.taskcluster.net/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 15:01:42 INFO - Running post-action listener: _resource_record_post_action 15:01:42 INFO - Running post-action listener: set_extra_try_arguments 15:01:42 INFO - ##### 15:01:42 INFO - ##### Running populate-webroot step. 15:01:42 INFO - ##### 15:01:42 INFO - Running pre-action listener: _resource_record_pre_action 15:01:42 INFO - Running main action method: populate_webroot 15:01:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:01:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:01:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:01:42 INFO - '--tppagecycles', 15:01:42 INFO - '7'], 15:01:42 INFO - 'tests': ['tsvgm']}}, 15:01:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:01:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:01:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:01:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:01:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:01:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:01:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:42 INFO - 'talos_options': ['--e10s'], 15:01:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:01:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:42 INFO - 'tests': ['damp', 'tps']}, 15:01:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:42 INFO - 'talos_options': ['--e10s'], 15:01:42 INFO - 'tests': ['damp', 'tps']}, 15:01:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:01:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:01:42 INFO - 'other': {'tests': ['a11yr', 15:01:42 INFO - 'ts_paint', 15:01:42 INFO - 'tpaint', 15:01:42 INFO - 'sessionrestore', 15:01:42 INFO - 'sessionrestore_no_auto_restore']}, 15:01:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:01:42 INFO - 'tests': ['a11yr', 15:01:42 INFO - 'ts_paint', 15:01:42 INFO - 'tpaint', 15:01:42 INFO - 'sessionrestore', 15:01:42 INFO - 'sessionrestore_no_auto_restore']}, 15:01:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:01:42 INFO - 'tests': ['a11yr', 15:01:42 INFO - 'ts_paint', 15:01:42 INFO - 'tpaint', 15:01:42 INFO - 'sessionrestore', 15:01:42 INFO - 'sessionrestore_no_auto_restore']}, 15:01:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:01:42 INFO - 'tests': ['a11yr', 15:01:42 INFO - 'ts_paint', 15:01:42 INFO - 'tpaint', 15:01:42 INFO - 'sessionrestore', 15:01:42 INFO - 'sessionrestore_no_auto_restore']}, 15:01:42 INFO - 'other_l64': {'tests': ['a11yr', 15:01:42 INFO - 'ts_paint', 15:01:42 INFO - 'tpaint', 15:01:42 INFO - 'sessionrestore', 15:01:42 INFO - 'sessionrestore_no_auto_restore']}, 15:01:42 INFO - 'other_nol64': {'tests': ['a11yr', 15:01:42 INFO - 'ts_paint', 15:01:42 INFO - 'tpaint', 15:01:42 INFO - 'sessionrestore', 15:01:42 INFO - 'sessionrestore_no_auto_restore']}, 15:01:42 INFO - 'svgr': {'tests': ['tsvgx', 15:01:42 INFO - 'tsvgr_opacity', 15:01:42 INFO - 'tart', 15:01:42 INFO - 'tscrollx', 15:01:42 INFO - 'cart']}, 15:01:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:01:42 INFO - 'tests': ['tsvgx', 15:01:42 INFO - 'tsvgr_opacity', 15:01:42 INFO - 'tart', 15:01:42 INFO - 'tscrollx', 15:01:42 INFO - 'cart']}, 15:01:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:42 INFO - 'tests': ['tp5o']}, 15:01:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:42 INFO - 'talos_options': ['--e10s'], 15:01:42 INFO - 'tests': ['tp5o']}, 15:01:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:42 INFO - 'talos_options': ['--xperf_path', 15:01:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:42 INFO - 'tests': ['tp5n']}, 15:01:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:01:42 INFO - 'talos_options': ['--e10s', 15:01:42 INFO - '--xperf_path', 15:01:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:01:42 INFO - 'tests': ['tp5n']}}, 15:01:42 INFO - 'talos.zip': {'path': '', 15:01:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:01:42 INFO - Running post-action listener: _resource_record_post_action 15:01:42 INFO - ##### 15:01:42 INFO - ##### Running create-virtualenv step. 15:01:42 INFO - ##### 15:01:42 INFO - Running pre-action listener: _resource_record_pre_action 15:01:42 INFO - Running main action method: create_virtualenv 15:01:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:01:42 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 15:01:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:01:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:01:42 INFO - Using real prefix '/usr' 15:01:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:01:42 INFO - Installing distribute.............................................................................................................................................................................................done. 15:01:44 INFO - Installing pip.................done. 15:01:44 INFO - Return code: 0 15:01:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:44 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 0x7f47ab8e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c850>, '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 0x1d88330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d887c0>, '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': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', '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 15:01:44 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 15:01:44 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 15:01:44 INFO - Using env: {'DISPLAY': ':0', 15:01:44 INFO - 'HOME': '/home/cltbld', 15:01:44 INFO - 'LANG': 'en_US.UTF-8', 15:01:44 INFO - 'LANGUAGE': 'en_US:en', 15:01:44 INFO - 'LOGNAME': 'cltbld', 15:01:44 INFO - 'MAIL': '/var/mail/cltbld', 15:01:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:44 INFO - 'MOZ_NO_REMOTE': '1', 15:01:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:44 INFO - 'NO_EM_RESTART': '1', 15:01:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:01:44 INFO - 'PWD': '/builds/slave/test-pgo', 15:01:44 INFO - 'SHELL': '/bin/bash', 15:01:44 INFO - 'SHLVL': '1', 15:01:44 INFO - 'TERM': 'linux', 15:01:44 INFO - 'TMOUT': '86400', 15:01:44 INFO - 'USER': 'cltbld', 15:01:44 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', 15:01:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:44 INFO - '_': '/tools/buildbot/bin/python'} 15:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:45 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 15:01:45 INFO - Cleaning up... 15:01:45 INFO - Return code: 0 15:01:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:01: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')]} 15:01:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01: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')]} 15:01:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:45 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 0x7f47ab8e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c850>, '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 0x1d88330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d887c0>, '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': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', '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 15:01:45 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 15:01:45 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 15:01:45 INFO - Using env: {'DISPLAY': ':0', 15:01:45 INFO - 'HOME': '/home/cltbld', 15:01:45 INFO - 'LANG': 'en_US.UTF-8', 15:01:45 INFO - 'LANGUAGE': 'en_US:en', 15:01:45 INFO - 'LOGNAME': 'cltbld', 15:01:45 INFO - 'MAIL': '/var/mail/cltbld', 15:01:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:45 INFO - 'MOZ_NO_REMOTE': '1', 15:01:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:45 INFO - 'NO_EM_RESTART': '1', 15:01:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:01:45 INFO - 'PWD': '/builds/slave/test-pgo', 15:01:45 INFO - 'SHELL': '/bin/bash', 15:01:45 INFO - 'SHLVL': '1', 15:01:45 INFO - 'TERM': 'linux', 15:01:45 INFO - 'TMOUT': '86400', 15:01:45 INFO - 'USER': 'cltbld', 15:01:45 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', 15:01:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:45 INFO - '_': '/tools/buildbot/bin/python'} 15:01:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:45 INFO - Downloading/unpacking psutil>=0.7.1 15:01:45 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 15:01:45 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 15:01:45 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 15:01:45 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 15:01:45 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 15:01:45 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 15:01:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:01:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:47 INFO - Installing collected packages: psutil 15:01:47 INFO - Running setup.py install for psutil 15:01:47 INFO - building 'psutil._psutil_linux' extension 15:01:47 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 15:01:47 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 15:01:47 INFO - building 'psutil._psutil_posix' extension 15:01:47 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 15:01:47 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 15:01:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:01:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:01:47 INFO - Successfully installed psutil 15:01:47 INFO - Cleaning up... 15:01:47 INFO - Return code: 0 15:01:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:47 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 0x7f47ab8e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c850>, '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 0x1d88330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d887c0>, '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': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', '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 15:01:47 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 15:01:47 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 15:01:47 INFO - Using env: {'DISPLAY': ':0', 15:01:47 INFO - 'HOME': '/home/cltbld', 15:01:47 INFO - 'LANG': 'en_US.UTF-8', 15:01:47 INFO - 'LANGUAGE': 'en_US:en', 15:01:47 INFO - 'LOGNAME': 'cltbld', 15:01:47 INFO - 'MAIL': '/var/mail/cltbld', 15:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:47 INFO - 'MOZ_NO_REMOTE': '1', 15:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:47 INFO - 'NO_EM_RESTART': '1', 15:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:01:47 INFO - 'PWD': '/builds/slave/test-pgo', 15:01:47 INFO - 'SHELL': '/bin/bash', 15:01:47 INFO - 'SHLVL': '1', 15:01:47 INFO - 'TERM': 'linux', 15:01:47 INFO - 'TMOUT': '86400', 15:01:47 INFO - 'USER': 'cltbld', 15:01:47 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', 15:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:47 INFO - '_': '/tools/buildbot/bin/python'} 15:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:01:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:01:49 INFO - Installing collected packages: mozsystemmonitor 15:01:49 INFO - Running setup.py install for mozsystemmonitor 15:01:50 INFO - Successfully installed mozsystemmonitor 15:01:50 INFO - Cleaning up... 15:01:50 INFO - Return code: 0 15:01:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:50 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 0x7f47ab8e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c850>, '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 0x1d88330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d887c0>, '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': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', '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 15:01:50 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 15:01:50 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 15:01:50 INFO - Using env: {'DISPLAY': ':0', 15:01:50 INFO - 'HOME': '/home/cltbld', 15:01:50 INFO - 'LANG': 'en_US.UTF-8', 15:01:50 INFO - 'LANGUAGE': 'en_US:en', 15:01:50 INFO - 'LOGNAME': 'cltbld', 15:01:50 INFO - 'MAIL': '/var/mail/cltbld', 15:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:50 INFO - 'MOZ_NO_REMOTE': '1', 15:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:50 INFO - 'NO_EM_RESTART': '1', 15:01:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:01:50 INFO - 'PWD': '/builds/slave/test-pgo', 15:01:50 INFO - 'SHELL': '/bin/bash', 15:01:50 INFO - 'SHLVL': '1', 15:01:50 INFO - 'TERM': 'linux', 15:01:50 INFO - 'TMOUT': '86400', 15:01:50 INFO - 'USER': 'cltbld', 15:01:50 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', 15:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:50 INFO - '_': '/tools/buildbot/bin/python'} 15:01:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:50 INFO - Downloading/unpacking blobuploader==1.2.4 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01:52 INFO - Downloading blobuploader-1.2.4.tar.gz 15:01:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:01:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01: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 15:01:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:01:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:53 INFO - Downloading docopt-0.6.1.tar.gz 15:01:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:01:53 INFO - Installing collected packages: blobuploader, requests, docopt 15:01:53 INFO - Running setup.py install for blobuploader 15:01:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:01:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:01:53 INFO - Running setup.py install for requests 15:01:53 INFO - Running setup.py install for docopt 15:01:54 INFO - Successfully installed blobuploader requests docopt 15:01:54 INFO - Cleaning up... 15:01:54 INFO - Return code: 0 15:01:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:54 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 0x7f47ab8e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c850>, '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 0x1d88330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d887c0>, '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': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', '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 15:01:54 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 15:01:54 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 15:01:54 INFO - Using env: {'DISPLAY': ':0', 15:01:54 INFO - 'HOME': '/home/cltbld', 15:01:54 INFO - 'LANG': 'en_US.UTF-8', 15:01:54 INFO - 'LANGUAGE': 'en_US:en', 15:01:54 INFO - 'LOGNAME': 'cltbld', 15:01:54 INFO - 'MAIL': '/var/mail/cltbld', 15:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:54 INFO - 'MOZ_NO_REMOTE': '1', 15:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:54 INFO - 'NO_EM_RESTART': '1', 15:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:01:54 INFO - 'PWD': '/builds/slave/test-pgo', 15:01:54 INFO - 'SHELL': '/bin/bash', 15:01:54 INFO - 'SHLVL': '1', 15:01:54 INFO - 'TERM': 'linux', 15:01:54 INFO - 'TMOUT': '86400', 15:01:54 INFO - 'USER': 'cltbld', 15:01:54 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', 15:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:54 INFO - '_': '/tools/buildbot/bin/python'} 15:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:01:54 INFO - Running setup.py (path:/tmp/pip-h87yf1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:01:54 INFO - Running setup.py (path:/tmp/pip-m6Xpha-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:01:54 INFO - Running setup.py (path:/tmp/pip-UZeAW4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:01:54 INFO - Running setup.py (path:/tmp/pip-c7rKJx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:01:54 INFO - Running setup.py (path:/tmp/pip-sysQqZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:01:54 INFO - Running setup.py (path:/tmp/pip-dcbByl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:01:54 INFO - Running setup.py (path:/tmp/pip-uXcIMZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:01:54 INFO - Running setup.py (path:/tmp/pip-94C2nM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:01:54 INFO - Running setup.py (path:/tmp/pip-62gbHk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:01:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:01:54 INFO - Running setup.py (path:/tmp/pip-znODfZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:01:55 INFO - Running setup.py (path:/tmp/pip-_7fY_W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:01:55 INFO - Running setup.py (path:/tmp/pip-BzRyKQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:01:55 INFO - Running setup.py (path:/tmp/pip-elfz__-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:01:55 INFO - Running setup.py (path:/tmp/pip-VH93KH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:01:55 INFO - Running setup.py (path:/tmp/pip-XFUTm0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:01:55 INFO - Running setup.py (path:/tmp/pip-EbveIS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:01:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:01:55 INFO - Running setup.py (path:/tmp/pip-u51Oy5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:01:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:01:55 INFO - Running setup.py install for manifestparser 15:01:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:01:55 INFO - Running setup.py install for mozcrash 15:01:55 INFO - Running setup.py install for mozdebug 15:01:55 INFO - Running setup.py install for mozdevice 15:01:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:01:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:01:55 INFO - Running setup.py install for mozfile 15:01:56 INFO - Running setup.py install for mozhttpd 15:01:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:01:56 INFO - Running setup.py install for mozinfo 15:01:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:01:56 INFO - Running setup.py install for mozInstall 15:01:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:01:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:01:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:01:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:01:56 INFO - Running setup.py install for mozleak 15:01:56 INFO - Running setup.py install for mozlog 15:01:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:01:56 INFO - Running setup.py install for moznetwork 15:01:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:01:56 INFO - Running setup.py install for mozprocess 15:01:56 INFO - Running setup.py install for mozprofile 15:01:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:01:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:01:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:01:56 INFO - Running setup.py install for mozrunner 15:01:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:01:56 INFO - Running setup.py install for mozscreenshot 15:01:57 INFO - Running setup.py install for moztest 15:01:57 INFO - Running setup.py install for mozversion 15:01:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:01:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:01:57 INFO - Cleaning up... 15:01:57 INFO - Return code: 0 15:01:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:01:57 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 0x7f47ab8e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c850>, '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 0x1d88330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d887c0>, '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': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', '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 15:01:57 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 15:01:57 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 15:01:57 INFO - Using env: {'DISPLAY': ':0', 15:01:57 INFO - 'HOME': '/home/cltbld', 15:01:57 INFO - 'LANG': 'en_US.UTF-8', 15:01:57 INFO - 'LANGUAGE': 'en_US:en', 15:01:57 INFO - 'LOGNAME': 'cltbld', 15:01:57 INFO - 'MAIL': '/var/mail/cltbld', 15:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:01:57 INFO - 'MOZ_NO_REMOTE': '1', 15:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:01:57 INFO - 'NO_EM_RESTART': '1', 15:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:01:57 INFO - 'PWD': '/builds/slave/test-pgo', 15:01:57 INFO - 'SHELL': '/bin/bash', 15:01:57 INFO - 'SHLVL': '1', 15:01:57 INFO - 'TERM': 'linux', 15:01:57 INFO - 'TMOUT': '86400', 15:01:57 INFO - 'USER': 'cltbld', 15:01:57 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', 15:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:01:57 INFO - '_': '/tools/buildbot/bin/python'} 15:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:01:57 INFO - Running setup.py (path:/tmp/pip-XbDtIt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 15:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:01:57 INFO - Running setup.py (path:/tmp/pip-dXKdb0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:01:57 INFO - Running setup.py (path:/tmp/pip-ZFKTzK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:01:57 INFO - Running setup.py (path:/tmp/pip-O7aWs7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:01:57 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)) 15:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:01:57 INFO - Running setup.py (path:/tmp/pip-1Hh4kW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:01:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 15:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:01:57 INFO - Running setup.py (path:/tmp/pip-OgQAjc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:01:57 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)) 15:01:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:01:57 INFO - Running setup.py (path:/tmp/pip-S1bMVP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 15:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:01:58 INFO - Running setup.py (path:/tmp/pip-dSp6RS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 15:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:01:58 INFO - Running setup.py (path:/tmp/pip-BMHm2C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 15:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:01:58 INFO - Running setup.py (path:/tmp/pip-2XG_9O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:01:58 INFO - Running setup.py (path:/tmp/pip-oW6Zdd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 15:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:01:58 INFO - Running setup.py (path:/tmp/pip-9QOyxC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 15:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:01:58 INFO - Running setup.py (path:/tmp/pip-30Bkh3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:01:58 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)) 15:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:01:58 INFO - Running setup.py (path:/tmp/pip-aAJF8T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 15:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:01:58 INFO - Running setup.py (path:/tmp/pip-8661PS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 15:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:01:58 INFO - Running setup.py (path:/tmp/pip-8S4Nh1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 15:01:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:01:58 INFO - Running setup.py (path:/tmp/pip-V15o4X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 15:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:01:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:01:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:01:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:00 INFO - Downloading blessings-1.6.tar.gz 15:02:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:02:00 INFO - Installing collected packages: blessings 15:02:00 INFO - Running setup.py install for blessings 15:02:00 INFO - Successfully installed blessings 15:02:00 INFO - Cleaning up... 15:02:00 INFO - Return code: 0 15:02:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:02:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:02:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:02:01 INFO - Reading from file tmpfile_stdout 15:02:01 INFO - Current package versions: 15:02:01 INFO - argparse == 1.2.1 15:02:01 INFO - blessings == 1.6 15:02:01 INFO - blobuploader == 1.2.4 15:02:01 INFO - docopt == 0.6.1 15:02:01 INFO - manifestparser == 1.1 15:02:01 INFO - mozInstall == 1.12 15:02:01 INFO - mozcrash == 0.16 15:02:01 INFO - mozdebug == 0.1 15:02:01 INFO - mozdevice == 0.48 15:02:01 INFO - mozfile == 1.2 15:02:01 INFO - mozhttpd == 0.7 15:02:01 INFO - mozinfo == 0.9 15:02:01 INFO - mozleak == 0.1 15:02:01 INFO - mozlog == 3.1 15:02:01 INFO - moznetwork == 0.27 15:02:01 INFO - mozprocess == 0.22 15:02:01 INFO - mozprofile == 0.28 15:02:01 INFO - mozrunner == 6.11 15:02:01 INFO - mozscreenshot == 0.1 15:02:01 INFO - mozsystemmonitor == 0.0 15:02:01 INFO - moztest == 0.7 15:02:01 INFO - mozversion == 1.4 15:02:01 INFO - psutil == 3.1.1 15:02:01 INFO - requests == 1.2.3 15:02:01 INFO - wsgiref == 0.1.2 15:02:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:01 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 0x7f47ab8e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c850>, '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 0x1d88330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d887c0>, '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': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', '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 15:02:01 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 15:02:01 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 15:02:01 INFO - Using env: {'DISPLAY': ':0', 15:02:01 INFO - 'HOME': '/home/cltbld', 15:02:01 INFO - 'LANG': 'en_US.UTF-8', 15:02:01 INFO - 'LANGUAGE': 'en_US:en', 15:02:01 INFO - 'LOGNAME': 'cltbld', 15:02:01 INFO - 'MAIL': '/var/mail/cltbld', 15:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:01 INFO - 'MOZ_NO_REMOTE': '1', 15:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:01 INFO - 'NO_EM_RESTART': '1', 15:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:02:01 INFO - 'PWD': '/builds/slave/test-pgo', 15:02:01 INFO - 'SHELL': '/bin/bash', 15:02:01 INFO - 'SHLVL': '1', 15:02:01 INFO - 'TERM': 'linux', 15:02:01 INFO - 'TMOUT': '86400', 15:02:01 INFO - 'USER': 'cltbld', 15:02:01 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', 15:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:01 INFO - '_': '/tools/buildbot/bin/python'} 15:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:01 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)) 15:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 15:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 15:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 15:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 15:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 15:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 15:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 15:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:02:01 INFO - Cleaning up... 15:02:01 INFO - Return code: 0 15:02:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:01 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 0x7f47ab8e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c850>, '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 0x1d88330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d887c0>, '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': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', '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 15:02:01 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 15:02:01 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 15:02:01 INFO - Using env: {'DISPLAY': ':0', 15:02:01 INFO - 'HOME': '/home/cltbld', 15:02:01 INFO - 'LANG': 'en_US.UTF-8', 15:02:01 INFO - 'LANGUAGE': 'en_US:en', 15:02:01 INFO - 'LOGNAME': 'cltbld', 15:02:01 INFO - 'MAIL': '/var/mail/cltbld', 15:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:01 INFO - 'MOZ_NO_REMOTE': '1', 15:02:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:01 INFO - 'NO_EM_RESTART': '1', 15:02:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:02:01 INFO - 'PWD': '/builds/slave/test-pgo', 15:02:01 INFO - 'SHELL': '/bin/bash', 15:02:01 INFO - 'SHLVL': '1', 15:02:01 INFO - 'TERM': 'linux', 15:02:01 INFO - 'TMOUT': '86400', 15:02:01 INFO - 'USER': 'cltbld', 15:02:01 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', 15:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:01 INFO - '_': '/tools/buildbot/bin/python'} 15:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:01 INFO - Downloading/unpacking jsonschema 15:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:02:03 INFO - Downloading/unpacking functools32 (from jsonschema) 15:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:03 INFO - Downloading functools32-3.2.3-2.tar.gz 15:02:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:02:03 INFO - warning: no files found matching '*.txt' 15:02:03 INFO - no previously-included directories found matching 'build' 15:02:03 INFO - no previously-included directories found matching 'dist' 15:02:03 INFO - no previously-included directories found matching '.git*' 15:02:03 INFO - Installing collected packages: jsonschema, functools32 15:02:03 INFO - Running setup.py install for functools32 15:02:03 INFO - warning: no files found matching '*.txt' 15:02:03 INFO - no previously-included directories found matching 'build' 15:02:03 INFO - no previously-included directories found matching 'dist' 15:02:03 INFO - no previously-included directories found matching '.git*' 15:02:03 INFO - Successfully installed jsonschema functools32 15:02:03 INFO - Cleaning up... 15:02:03 INFO - Return code: 0 15:02:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:02:03 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 0x7f47ab8e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cbb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d8a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e1c850>, '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 0x1d88330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d887c0>, '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': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', '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 15:02:03 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 15:02:03 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 15:02:03 INFO - Using env: {'DISPLAY': ':0', 15:02:03 INFO - 'HOME': '/home/cltbld', 15:02:03 INFO - 'LANG': 'en_US.UTF-8', 15:02:03 INFO - 'LANGUAGE': 'en_US:en', 15:02:03 INFO - 'LOGNAME': 'cltbld', 15:02:03 INFO - 'MAIL': '/var/mail/cltbld', 15:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:03 INFO - 'MOZ_NO_REMOTE': '1', 15:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:03 INFO - 'NO_EM_RESTART': '1', 15:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:02:03 INFO - 'PWD': '/builds/slave/test-pgo', 15:02:03 INFO - 'SHELL': '/bin/bash', 15:02:03 INFO - 'SHLVL': '1', 15:02:03 INFO - 'TERM': 'linux', 15:02:03 INFO - 'TMOUT': '86400', 15:02:03 INFO - 'USER': 'cltbld', 15:02:03 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', 15:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:03 INFO - '_': '/tools/buildbot/bin/python'} 15:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:02:04 INFO - Downloading/unpacking flake8 15:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:02:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:02:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:02:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:02:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:02:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:02:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:02:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:02:06 INFO - no previously-included directories found matching 'docs/_build' 15:02:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:02:06 INFO - Running setup.py install for pep8 15:02:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:02:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:02:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:02:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:02:06 INFO - no previously-included directories found matching 'docs/_build' 15:02:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:02:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:02:06 INFO - Cleaning up... 15:02:06 INFO - Return code: 0 15:02:06 INFO - Running post-action listener: _resource_record_post_action 15:02:06 INFO - Running post-action listener: _start_resource_monitoring 15:02:06 INFO - Starting resource monitoring. 15:02:06 INFO - ##### 15:02:06 INFO - ##### Running install step. 15:02:06 INFO - ##### 15:02:06 INFO - Running pre-action listener: _resource_record_pre_action 15:02:06 INFO - Running main action method: install 15:02:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:02:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:02:07 INFO - Reading from file tmpfile_stdout 15:02:07 INFO - Detecting whether we're running mozinstall >=1.0... 15:02:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:02:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:02:07 INFO - Reading from file tmpfile_stdout 15:02:07 INFO - Output received: 15:02:07 INFO - Usage: mozinstall [options] installer 15:02:07 INFO - Options: 15:02:07 INFO - -h, --help show this help message and exit 15:02:07 INFO - -d DEST, --destination=DEST 15:02:07 INFO - Directory to install application into. [default: 15:02:07 INFO - "/builds/slave/test-pgo"] 15:02:07 INFO - --app=APP Application being installed. [default: firefox] 15:02:07 INFO - mkdir: /builds/slave/test-pgo/build/application 15:02:07 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'] 15:02:07 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 15:02:19 INFO - Reading from file tmpfile_stdout 15:02:19 INFO - Output received: 15:02:19 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:02:19 INFO - Running post-action listener: _resource_record_post_action 15:02:19 INFO - ##### 15:02:19 INFO - ##### Running run-tests step. 15:02:19 INFO - ##### 15:02:19 INFO - Running pre-action listener: _resource_record_pre_action 15:02:19 INFO - Running main action method: run_tests 15:02:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:02:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:02:19 INFO - Python 2.7.3 15:02:19 INFO - Return code: 0 15:02:19 INFO - grabbing minidump binary from tooltool 15:02:19 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')]} 15:02:19 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 0x1e1c850>, '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 0x1d88330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d887c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:02:19 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 15:02:19 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 15:02:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:02:19 INFO - Return code: 0 15:02:19 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:02:19 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:02:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:02:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:02:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:02:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:02:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:02:20 INFO - Return code: 0 15:02:20 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/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 15:02:20 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/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 15:02:20 INFO - Using env: {'DISPLAY': ':0', 15:02:20 INFO - 'HOME': '/home/cltbld', 15:02:20 INFO - 'LANG': 'en_US.UTF-8', 15:02:20 INFO - 'LANGUAGE': 'en_US:en', 15:02:20 INFO - 'LOGNAME': 'cltbld', 15:02:20 INFO - 'MAIL': '/var/mail/cltbld', 15:02:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:02:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:02:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:02:20 INFO - 'MOZ_NO_REMOTE': '1', 15:02:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:02:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:02:20 INFO - 'NO_EM_RESTART': '1', 15:02:20 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:02:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:02:20 INFO - 'PWD': '/builds/slave/test-pgo', 15:02:20 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:02:20 INFO - 'SHELL': '/bin/bash', 15:02:20 INFO - 'SHLVL': '1', 15:02:20 INFO - 'TERM': 'linux', 15:02:20 INFO - 'TMOUT': '86400', 15:02:20 INFO - 'USER': 'cltbld', 15:02:20 INFO - 'XDG_SESSION_COOKIE': '574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315', 15:02:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:02:20 INFO - '_': '/tools/buildbot/bin/python'} 15:02:20 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/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 15:02:20 INFO - mozversion application_buildid: 20160314121843 15:02:20 INFO - mozversion application_changeset: cd9a385c536ce27831ff580e4a41d2f16e73d18a 15:02:20 INFO - mozversion application_display_name: Firefox 15:02:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:02:20 INFO - mozversion application_name: Firefox 15:02:20 INFO - mozversion application_remotingname: firefox 15:02:20 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:02:20 INFO - mozversion application_vendor: Mozilla 15:02:20 INFO - mozversion application_version: 46.0 15:02:20 INFO - mozversion platform_buildid: 20160314121843 15:02:20 INFO - mozversion platform_changeset: cd9a385c536ce27831ff580e4a41d2f16e73d18a 15:02:20 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:02:20 INFO - mozversion platform_version: 46.0 15:02:20 INFO - using testdate: 1457992940 15:02:20 INFO - actual date: 1457992940 15:02:21 INFO - starting webserver on 'localhost:58010' 15:02:21 INFO - SUITE-START | Running 3 tests 15:02:21 INFO - TEST-START | dromaeo_css 15:02:21 INFO - operating with platform_type : linux_ 15:02:21 INFO - Initialising browser for dromaeo_css test... 15:02:21 INFO - TEST-INFO | started process 7416 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMyfqOY/profile http://localhost:58010/getInfo.html) 15:02:25 INFO - PROCESS | 7416 | __metrics Screen width/height:1600/1200 15:02:25 INFO - PROCESS | 7416 | colorDepth:24 15:02:25 INFO - PROCESS | 7416 | Browser inner width/height: 1024/697 15:02:25 INFO - PROCESS | 7416 | __metrics 15:02:25 INFO - PROCESS | 7416 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:02:26 INFO - TEST-INFO | 7416: exit 0 15:02:26 INFO - Browser initialized. 15:02:26 INFO - Running cycle 1/1 for dromaeo_css test... 15:02:26 INFO - TEST-INFO | started process 7505 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMyfqOY/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:02:38 INFO - PROCESS | 7505 | RSS: Main: 136679424 15:02:38 INFO - PROCESS | 7505 | 15:03:29 INFO - PROCESS | 7505 | 1457993009420 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:05:37 INFO - PROCESS | 7505 | Cycle 1(1): loaded http://localhost:58010/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58010/tests/dromaeo/cssquery-ext.html) 15:05:38 INFO - PROCESS | 7505 | RSS: Main: 250167296 15:05:38 INFO - PROCESS | 7505 | 15:08:40 INFO - PROCESS | 7505 | Cycle 1(1): loaded http://localhost:58010/tests/dromaeo/cssquery-ext.html (next: http://localhost:58010/tests/dromaeo/cssquery-jquery.html) 15:08:41 INFO - PROCESS | 7505 | RSS: Main: 219062272 15:08:41 INFO - PROCESS | 7505 | 15:11:43 INFO - PROCESS | 7505 | Cycle 1(1): loaded http://localhost:58010/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58010/tests/dromaeo/cssquery-mootools.html) 15:11:43 INFO - PROCESS | 7505 | RSS: Main: 235020288 15:11:43 INFO - PROCESS | 7505 | 15:14:45 INFO - PROCESS | 7505 | Cycle 1(1): loaded http://localhost:58010/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58010/tests/dromaeo/cssquery-prototype.html) 15:14:46 INFO - PROCESS | 7505 | RSS: Main: 204877824 15:14:46 INFO - PROCESS | 7505 | 15:17:48 INFO - PROCESS | 7505 | Cycle 1(1): loaded http://localhost:58010/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58010/tests/dromaeo/cssquery-yui.html) 15:17:49 INFO - PROCESS | 7505 | RSS: Main: 208158720 15:17:49 INFO - PROCESS | 7505 | 15:20:51 INFO - PROCESS | 7505 | Cycle 1(1): loaded http://localhost:58010/tests/dromaeo/cssquery-yui.html (next: http://localhost:58010/tests/dromaeo/cssquery-dojo.html) 15:20:51 INFO - PROCESS | 7505 | RSS: Main: 247902208 15:20:51 INFO - PROCESS | 7505 | 15:20:51 INFO - PROCESS | 7505 | __start_tp_report 15:20:51 INFO - PROCESS | 7505 | _x_x_mozilla_page_load 15:20:51 INFO - PROCESS | 7505 | _x_x_mozilla_page_load_details 15:20:51 INFO - PROCESS | 7505 | |i|pagename|runs| 15:20:51 INFO - PROCESS | 7505 | |0;dojo.html;3271.7873338233;3275.8034517928927;3307.272400071985;3308.8511017004216;3333.1667083229195;5239.1093514102595;5239.292695486109;5252;5267.86830329242;5303.124984377578;5228.8692782680455;5252.212168174776;5278.841634750964;5288.418273989868;5333.813316533922;4742.668013239075;4794.208955522335;4854.4174699036075;4884.096442158194;4937.456879743226;4790.54489823468;4822.204336284526;4823.758812059401;4825.469198388192;4832.565069143777;4768.165571025074;4774.880627984294;4828.082664293791;4831.492693267209;4870.464248932614;4853.611711063107;4923.556879880792;4924.704517728947;4926.9014619707405;4952.678075925053;4856.514348565151;4863.319135321058;4885.43817460993;4890.951090489085;4894.241392584119;4973.303737476756;5068.163752980754;5074.391073071255;5129.025485157808;5155.046316431472;5572.637778544422;5611.635243709186;5637.154426836008;5664.688442135681;5731.684757338345;5724.198612194296;5756.769729210827;5760.423957604248;5766.913496297559;5771.797987070474;5154.304168937183;5219.791208351661;5308.893822123575;5330.093884039723;5330.706811125387;5723.313202415654;5761.107028410603;5763.164341170591;5768.653880767168;5775.48020678141;5574.916376254359;5578.079616863253;5580.497755202051;5581.274434323512;5597.328320601554;5386.299781028441;5447;5612.382637909826;5653.547716182696;5674.744636491368;5593.300837395325;5612;5632.85917852057;5649.209110724501;5654.943450565442;5607.299087614048;5651.8304450866535;5662.094064949588;5670.773169073191;5680.77276908919;4231.809568569422;4252.85115020979;4292.248856450109;4313.2883074292395;4314.352847072902;3923.8822835314986;3961.3265744822875;3961.4255932890146;3967.3255546557157;3983.9203215935518;5199.688018718889;5277.63056586043;5302.522772950453;5304.257403963448;5305.4164041955355;5449.455054494519;5598.86002849932;5612.494875461228;5623.240862483594;5658.519025882763;5186.455422180692;5203.791848326025;5214.0875346814155;5224.190250511177;5241.737913104405;4743.430788305425;4790.137775200427;4804.399450068741;4812.590929770939;4837.153498137812;5722.456366645162;5743.798967036134;5762.337331206881;5762.654240745569;5809.477147056785;5610.326760788732;5647.265855438766;5659.6321239119325;5669.546436285004;5673.205751194753;5694.886102278014;5714.457126572969;5729.856753581027;5787.5369970401425;5809.30288365382;5529.253550770594;5607.41122182165;5614.803481878114;5627.634203776742;5644.379118296902;5576.470235327637;5580.302462192226;5585.69278689676;5585.860353491195;5586.748596313095;5402.702851343057;5429.484199001088;5458.6724796512335;5487;5489.3687225969525;5461.1262198048125;5463.644863083887;5463.72681365938;5476.808311709071;5490.149026900836;5338;5343.118385466354;5345;5352.866178345416;5419.83740487786;5448.155535891943;5453.7818487260065;5476.069068258326;5511.145772405283;5520.503154715934;5414.187871819258;5459.454054594509;5459.781608735606;5464.3442786865835;5466.125419932791 15:20:51 INFO - PROCESS | 7505 | |1;ext.html;553.7895599672124;554.8335499350196;571.2858926342074;580.8054301808894;597.9252593425822;30532.542011869813;31121.221969450777;31128.68871311289;38728.612713872855;39500.60499395005;41577.7921110394;41888.79055604725;41987.37018944718;42065.78967105168;42099.78950105253;8843.159899809507;9042.909570904272;9053.230475409599;9054.818903621923;9069;8716.912830871705;8895;8919.866202006942;8927.151920567569;8935.463872167658;8880.911190888106;8942.329325300596;8957.641694332218;8958.059403762609;8958.104189581056;9020.052894446088;9094.77263068422;9107.180353768194;9121;9140.131687489711;8909.242714369286;8986.820263594756;9057.818843623156;9071.682491112779;9077.409968352036;42315.57684423178;42672.78663606693;42783;42926;42960.570394295966;3768.152165762709;3784.375578029622;3833.4824798652103;3846.0209917543066;3934.173823497069;32777.672223277936;32949.341013179604;32986.34027319464;33207.667923320696;37335.4399684005;4034.4553485279407;4078.082431452929;4111.09555897702;4116.320403865376;4136.565660605623;301870;306058;306152;307443;307890;57816.71091644515;59773.70113149406;66216;66591.66704166448;68900.65549672219;58841.70579147077;59018.70490647519;59153.704231478565;59390.70304648535;59473.702631486565;15564.221788910509;15758.527244182693;15859.207039647972;15865.52403427899;15867.206639668202;11040.613578524713;11043.116550675926;11068.612598559012;11070.501827417786;11313.377764222882;21446.892765536384;22038.228661996753;22038.559228815335;22103.115875365125;22221.555568888532;8210.712625058095;8401.663933442594;8495.192956669107;8548.572571371407;8602.354823388147;999.5983756526407;1018.0786388318584;1074.6990842564094;1112.4882554025078;1170.666360087371;30017.549736753965;30029.699703003127;30131;30564.083077507712;30783.23041923925;1106.900378965881;1161.4134861894688;1164.6273192578462;1220.9987809995896;1242.4409015942863;13604.319784010957;15675.29461174227;15678.451254206277;16060.51238070538;16071.11608861524;349852;353227;354020;354432;357164;57889.71055144782;58173.70913145492;58189;58427.123593146134;58573.414265857646;1481.2445652717192;1487.3976039704153;1490.3814916809404;1493.57433131557;1515.3786947351532;31319.06042818719;31345.686543134278;31637.20906977344;31783.364332713678;31793.682063179072;49518;49946.75026624989;50048;50192.498075020245;50331.74834125806;323859;325453;326973;328909;330039;30691.846540767154;31192.37615247637;35108.12229694278;36398.27203455969;36636.45045324376;43947.78026109977;45671;45790.542094578625;45955.77022114868;46174.769126154155;37673.246535069695;37685.4347184787;38995.805020974716;39151.2169756609;39270.4109438353;33194.83402582972;38098.619013809504;39207.6079239204;39270.607293926696;41687.374689379074;36073;36625.45061824128;36861.631383686894;37440.251194975404;41872.58127418809;32617.673823262412;33632.327353453285;34025.82987085049;34260.65739342575;34331.79838705633;25579.48841023132;25601.48797024012;25794.871025644752;28393.574096388984;28824.279393014505 15:20:51 INFO - PROCESS | 7505 | |2;jquery.html;393.2547821877542;393.54545499947534;394.1230761555539;397.52098721041165;399.53254692010347;12632.62102136935;16624.91687541562;17080.23138958747;17129.400470983503;18390.448286551426;12295.569655062074;12590;13411.798823017663;17405.129743512807;17532.474025779247;5238.371395432544;5408.702521361323;5428.701421421821;5432.619716619838;5435.266239057736;5272.420033796279;5340.225667278242;5359.5712343012665;5361.249425080492;5363.731813409334;4051.230266249418;4203.810828512725;5311.654742441749;5787.450192231752;5788.218590490293;5601.775928962837;5868.41315868414;5884.293884733816;5892.882142357172;5894.705264736789;5467.824417750203;5629.211910332516;5644.322681278232;5644.604877658566;5662.037453632893;13375.531856385078;13618.795718064237;17879.28482860684;21229.68155477669;21298.148074077017;2147.387994421598;2209.6464565669576;2215.8448908576406;2257.582347265761;2272.625016872231;9733.367331123454;10092.243081768824;10422.426766527838;10537.367757934471;12715.87284127156;1786.5444311700433;1808.97286540702;1941.6116776644728;2033.4408037789578;2051.7845626209332;56979.71510142464;57103.71448142733;57106.428935710945;59507;61242.38757612456;9252.213561847184;9579.233661307078;9889.653862114792;10031.849522257173;10089.142422894136;13149;13224.669383265495;13265.867341326657;13269.469221231042;13337.73324533504;7274.927250727531;7299.343059124704;7384.26157384268;7404.629768511553;7417.443691723142;7156;7160.176579693298;7169.068021157216;7172.175199851979;7211.783646490614;4243.554426785205;4299.333603291495;4342.240107981091;4390.012247244408;4564.315352697122;1768.1295605565385;1776.8223177682128;1820.162725146421;1876.6434377468238;1922.6827573450223;496.4762175904456;990.301837204769;1015.8374660054355;1033.8087453821067;1082.8375743638517;9502;10798.352098874093;10913.23607347478;10963.451827408757;11056.889431105747;489.89712160446703;510.6757209172128;513.4382590493499;519.9714015729096;529.4149964289405;6456.967715161394;6631.602103873686;6789.1852977643;6822.624755638389;6829.975503674488;561262;573452;577330;578358;582841;48313.75843120832;48994.51005489971;50187.49812501901;77854.61072694714;79121.60439197767;514.8018013064997;517.4411635433722;518.2381898609113;518.4116028307898;520.5029197116744;15017.77473337879;15155.242237888282;15633.530994070195;15637.061776293458;16018.439354622533;34936.650633494355;35662;36313.818430907675;36436.45345319769;36506.087347816516;42243;42773.786131069144;44094.77952610217;44288.11423771571;45068.54931450643;7321.304476074764;7742.883856742041;7889.289963903277;7943.682252709827;7977.521348718863;10583.788324233627;11177.385243811668;11365.48855301497;11654.125940554663;11823.645290641294;10003.34978226413;10019.899801001897;10107.39355638664;10310.484475776331;10450.529726162493;9721.319507634398;10367.533460994122;10432.68701938943;10506.106980906708;10703.518341674488;7407.407407407502;9622.855657165008;9841.311108222355;10009.099181073447;10133.695989120339;7814.257645523666;7835.960820195863;7865.842683146419;7927.207279272026;7950.4832185907735;8664.263537599374;9332.626694932127;9624.326297159412;9624.51877406141;9741.707748767549 15:20:51 INFO - PROCESS | 7505 | |3;mootools.html;1568.7097886890924;1583.952481425557;1798.181827268593;1884.0768023668406;1933.632609804138;7955.840883182333;8152.633131509081;8155.143709910463;8159.306458950981;8168.101508834031;8044.8391032179325;8075.757727268191;8078.434509584332;8097.2712455878955;8101.756947291576;2417.2506522977933;2429.1255148146697;2449.5713250181147;2459.434330104077;2466.05057053035;2470.950580988379;2477.938051548708;2492.22740950306;2496.8377055491424;2497.7377375375595;2075.2321640992777;2127.393692797553;2130.1585873579925;2390.032037025008;2404.843685160468;2337.5208082343165;2385.5348207099623;2385.666006759055;2405.7353691093967;2408.14510848648;2378.4767351182713;2391.629297458897;2421.406755344934;2423.7697418745192;2425.199684104259;7104.183018952835;7221.350078492961;7632.313091821763;7834.373250140032;8035.276825085712;5068.3917929848285;5171.896562068738;5174.094533456668;5180.222966555047;5181.326427564431;3071.616047994001;3099.3801239751915;3119.5632611434417;3162.4623813951684;3166.651668316483;1013.8276492996134;1028.5268776362882;1044.8850626431085;1065.0733861540432;1109.7114750164935;11429.257098288585;11497.999999999916;11500.884991150066;11519.827202591969;11532.308061516336;4696.272077827942;4711.316859055418;4725.834595789131;4742.099001189763;4769.642276829251;9905.851412228822;9952.80094398108;9975.800483990279;9983.850242246372;9987.60049598008;5132.461091585405;5139.12634852076;5150.536451719363;5158.174692049254;5158.690478571298;4715.882102947385;4717.22165842639;4721.032188401369;4724.811007559659;4728.40894888139;3903.375459926398;3912.550056743454;3928.705347098979;3932.6853851691794;3968.40473928913;1257.1702676233824;1267.8034904589804;1287.5429222626021;1289.9677508062373;1292.2892409174917;1390.5967269491734;1456.5266288456294;1481.525911708243;1484.5620541940154;1498.1460567476433;7721.727367222188;7798.883016754753;7811.336036436853;7854.803629909298;7886.881696774553;553.0956885492249;557.736726314897;560.4311623701946;561.0238185557101;562.2409746841813;5246.475352464723;6203.441690247809;6234.875302493925;6238.220222472191;6248.5313601480075;8677.1756683115;9316.301277404222;9705.078017588317;9713.854292185622;9731.610735570639;9196.678116266032;9532.52337383128;9536.666216682383;9576.760580985392;9579.521023948775;7743.419243556756;7758.612069396508;7798.53208807462;7820.553197658452;7822.335101516434;7380.630968451448;7476.177620461854;7506.061742282215;7508.962455187689;7676.078870535572;8716.215540601377;8880.200781929658;9136.223421009288;9151.084891510796;9164.541772911462;9018.241442918568;9253.259739220712;9273.119053689888;9276.675316364164;9455.243580513405;7419.332260096618;7456.664450099867;7463.328300452768;7498.512596681198;7502.474826762293;7497.437692173218;7590.430717696085;7635.00744903159;7635.121960974337;7636.694532218871;7514.323710866049;7514.812129696583;7579.204183560647;7594.6202689866395;7617.961910190414;7505.774826755206;7542.773716788505;7568.205338439385;7654.8086297843;7656.310932016146;7578.621068946641;7764.88352674699;7770;7789.805254868447;7790.1041380241995;7053.188883278283;7081.964590177016;7091.184513780981;7121.857562848818;7139.286071392819;7170.39051680613;7207.351338379571;7287.453440991841;7310.817229569303;7321.304476074764 15:20:51 INFO - PROCESS | 7505 | |4;prototype.html;374.73768362146495;379.74557046778654;380.3458052150301;384.40417353102686;389.23515292450327;5968.641881487109;5970.761169553223;5981.820545383645;6007.669578173204;6028.276606807184;5909.433999990006;5932.851678708034;5952.047672372421;5955.315138759044;5966.46301832835;4516.661250406224;4647.60495357895;4651.837185698484;4670.696404733699;4686.601638860701;4646.744429056401;4651.7441540715245;4660.580547750702;4663.7668116594205;4676.228422310314;4430;4516.525764794698;4519.118771839492;4617.884552886171;4624.352590637297;4549.181147393468;4580.450345958473;4581.221192397284;4587.174308624446;4607.884802879921;4019.4573732546023;4043.696722745806;4048.838046478137;4055.655269302113;4079.938800917989;5425.728713564306;5546.611737178399;5546.613346663335;5621.072523033695;5663.405342439067;5360.2763626910255;5371.811986580451;5374.973125134388;5381.192821076831;5389.865253368697;6330.17707698001;6332.335104813974;6343.777967771152;6344.524160687921;6350.428461438447;4404.581564751344;4512.323151527265;4513.480949690795;4552.271636538138;4555.726656400627;6439.83900402489;6569.868602627921;6573.769918052845;6578.046183303442;6579.572327798725;4614.676972611885;4615.9076818463445;4621.260598304255;4632.235681112578;4635.1656701794;4678.906421871544;4686.906261874743;4698.812047518061;4700.341952126705;4704.882377940579;5300.655457395257;5345.037893179187;5432.185172224119;5437.401885792559;5455.290812194468;6332.968335158294;6390.360963903572;6392.968035159794;6393.041043843367;6397.7440902364315;1701.6766814305242;1719.17479609788;1719.75063615775;1720.6128621060411;1720.8537274331823;1174.8061569841052;1175.6590588729173;1195.9581414650445;1199.3823181061587;1204.3616883051996;6092.69536523181;6100.908486372708;6101.633901965896;6110.877782444326;6111.908321375183;6487.513436492282;6502;6503.447206987459;6505.154329937078;6510;5980.192673989043;6091.451769340781;6092.116643086728;6104.542159338067;6106.145139680449;3475.2354482013916;3500.0899766061007;3500.1599616091953;3503.4569641705575;3507.4563442666426;6513.576617519846;6661.467082633378;6674.699638516181;6718.93281067183;6729.798106056826;6693.765718199839;6706.195256569145;6734.124563806674;6734.932650673529;6745.898811517831;6759.5606285591275;6759.695813688396;6771.796846094625;6773.5258531904265;6774.864502709918;6385.329540398191;6498.772542961163;6532.608043517404;6537.084808126771;6539.967300163468;6435.099086127852;6438.163038804925;6441.516886233458;6442.387973142544;6446.129772480843;6749.898751518829;6751.93248067513;6759.966200168968;6761.830954226184;6764.3573860483175;4710.4347478302825;4711.481737008995;4754.381930349033;4762.4285085789925;4783.6651434399255;6555.475561955128;6563.0811686364905;6565;6566.737330506726;6570.8357291068105;6344.873102537831;6346.365363463801;6347.238331400077;6348.238211414659;6370.26741924666;6227.439530442282;6375.203099612549;6384.968075159594;6416.711247993945;6420.101185833893;6323.9683801580695;6369.49044076482;6372.936270637234;6375.776847810304;6382.32985536512;6437.742490300336;6439.67801609927;6447;6447.2263328400895;6447.4197322241225;6155.938440615716;6281.874362512815;6286.465650419583;6286.874262514632;6288.308286088435 15:20:51 INFO - PROCESS | 7505 | |5;yui.html;929.3587424676973;936.4240991790049;938.6667732954801;944.6504793226503;964.0263334032625;14332.713345733078;14432.98969072164;14523;15909.124998125099;16262.105584192865;14917.776233356508;15005.624859378493;15014;15051.62370940727;15084.32120554575;736.2821249281934;761.4555592751182;909.9545022748853;923.1276443760648;924.2144177449181;891.5854127830557;912.803747194353;916.5371487398854;919.0717375450776;919.8252332056887;964.2816102004017;964.7154089543601;964.9372790768613;964.9517524123801;965.0205041882494;776.5185584937318;800.2237829305535;938.3759799733169;961.6153538584553;961.889382720989;695.3185877839745;699.136566340569;700.1178515070997;700.1528150937372;701.6877489517167;14461.927690361586;14494.130352178903;14543.927280363636;14544.854551454457;14552.92723536386;13101.47594096235;13527.18836869781;13578.321083945862;13592.456301747918;13632.454701812016;11407.714807129805;11485.253458525169;11558.942205289004;11601.709957251136;11666.59166929162;3849.8845034649007;3911.6479516843337;3913.62820532049;3914.745541539791;3918.216356728637;51458.48541514574;51912.74043629796;51964.96070078615;52646.47353526454;53106.203406948924;10410.063094321547;10688.25182237236;11236.887631123747;11289.209755317213;11586.76826463466;18874.15066322019;19061.714074288895;19065.809341906403;19071.332503362315;19097;7866.449348545661;7868.921310786819;7954.960225198953;8046.678132874737;8142.226488483585;4509.932351014738;4551.954480455153;4591.47198072226;4594.448666160082;4671.11248862715;3194.6805319467867;3221.597300337458;3225.903222903317;3232.725218356419;3232.870685172567;577.2466930655451;590.7725525672647;595.6604735300923;599.6701814002369;605.1195510532253;554.206797739389;659.350539718377;690.3959035843637;690.6063543779998;737.8413641067197;9059.048799876049;9114.726558203265;9288.860667089999;9466.85455640916;9487.003864594257;547.4853637580661;569.814810186691;597.7280337446451;621.8283535906114;669.7689297192461;4302.9569704303185;4419.18245124653;4453.242948698729;4499.257622492318;4521.208788462006;57560.71219643875;57713;57865.421345786;57875.71062144746;58038.4196158033;52816.20775688291;55100.448995509534;55453;55925;56209.15686264709;50522.242166367534;53112.73443632834;53491;54308.728456357465;54427;9551.0926461986;9552.331336806357;9612.66355677548;9708.563114659999;9888.604455821687;33913.49129763105;35124.29751404907;35960.64039359573;36011.45982810207;36234;46038.30942535798;46472.302915456974;46597;47223.29165062596;47225.763871180425;11532.25040372373;12042.578509752117;12326.691832704255;12633.2420054797;12803.975681945236;11359.318440893572;11451.25566838153;11512.136589755635;11582.478788454708;11899.940500297444;12077.57728479499;12298.877011229773;12433.626991190278;12466.68833279139;12499.93750031244;11534.711632208926;11936.462859171532;12175.45210465549;12298;12657.683557911127;11161.49773260189;11482;11540.859330191333;11736.237144585575;11847.70380740454;9730.805383892424;9835.901640983784;9991.318367853157;10162.949185254027;10266.178705703376;9875.901240987498;9993.250506212209;10038.444255828932;10403.687889363331;10616.734581635521 15:20:51 INFO - PROCESS | 7505 | __end_tp_report 15:20:51 INFO - PROCESS | 7505 | __start_cc_report 15:20:51 INFO - PROCESS | 7505 | _x_x_mozilla_cycle_collect,914 15:20:51 INFO - PROCESS | 7505 | __end_cc_report 15:20:51 INFO - PROCESS | 7505 | __startTimestamp1457994051815__endTimestamp 15:20:51 INFO - PROCESS | 7505 | 15:20:51 INFO - PROCESS | 7505 | ------- Summary: start ------- 15:20:51 INFO - PROCESS | 7505 | Number of tests: 6 15:20:51 INFO - PROCESS | 7505 | 15:20:51 INFO - PROCESS | 7505 | [#0] dojo.html Cycles:165 Average:5233.88 Median:5419.84 stddev:548.86 (10.1%) stddev-sans-first:528.52 15:20:51 INFO - PROCESS | 7505 | Values: 3271.8 3275.8 3307.3 3308.9 3333.2 5239.1 5239.3 5252.0 5267.9 5303.1 5228.9 5252.2 5278.8 5288.4 5333.8 4742.7 4794.2 4854.4 4884.1 4937.5 4790.5 4822.2 4823.8 4825.5 4832.6 4768.2 4774.9 4828.1 4831.5 4870.5 4853.6 4923.6 4924.7 4926.9 4952.7 4856.5 4863.3 4885.4 4891.0 4894.2 4973.3 5068.2 5074.4 5129.0 5155.0 5572.6 5611.6 5637.2 5664.7 5731.7 5724.2 5756.8 5760.4 5766.9 5771.8 5154.3 5219.8 5308.9 5330.1 5330.7 5723.3 5761.1 5763.2 5768.7 5775.5 5574.9 5578.1 5580.5 5581.3 5597.3 5386.3 5447.0 5612.4 5653.5 5674.7 5593.3 5612.0 5632.9 5649.2 5654.9 5607.3 5651.8 5662.1 5670.8 5680.8 4231.8 4252.9 4292.2 4313.3 4314.4 3923.9 3961.3 3961.4 3967.3 3983.9 5199.7 5277.6 5302.5 5304.3 5305.4 5449.5 5598.9 5612.5 5623.2 5658.5 5186.5 5203.8 5214.1 5224.2 5241.7 4743.4 4790.1 4804.4 4812.6 4837.2 5722.5 5743.8 5762.3 5762.7 5809.5 5610.3 5647.3 5659.6 5669.5 5673.2 5694.9 5714.5 5729.9 5787.5 5809.3 5529.3 5607.4 5614.8 5627.6 5644.4 5576.5 5580.3 5585.7 5585.9 5586.7 5402.7 5429.5 5458.7 5487.0 5489.4 5461.1 5463.6 5463.7 5476.8 5490.1 5338.0 5343.1 5345.0 5352.9 5419.8 5448.2 5453.8 5476.1 5511.1 5520.5 5414.2 5459.5 5459.8 5464.3 5466.1 15:20:51 INFO - PROCESS | 7505 | 15:20:51 INFO - PROCESS | 7505 | [#1] ext.html Cycles:180 Average:50478.47 Median:20941.50 stddev:86257.08 (411.9%) stddev-sans-first:86417.60 15:20:51 INFO - PROCESS | 7505 | Values: 553.8 554.8 571.3 580.8 597.9 30532.5 31121.2 31128.7 38728.6 39500.6 41577.8 41888.8 41987.4 42065.8 42099.8 8843.2 9042.9 9053.2 9054.8 9069.0 8716.9 8895.0 8919.9 8927.2 8935.5 8880.9 8942.3 8957.6 8958.1 8958.1 9020.1 9094.8 9107.2 9121.0 9140.1 8909.2 8986.8 9057.8 9071.7 9077.4 42315.6 42672.8 42783.0 42926.0 42960.6 3768.2 3784.4 3833.5 3846.0 3934.2 32777.7 32949.3 32986.3 33207.7 37335.4 4034.5 4078.1 4111.1 4116.3 4136.6 301870.0 306058.0 306152.0 307443.0 307890.0 57816.7 59773.7 66216.0 66591.7 68900.7 58841.7 59018.7 59153.7 59390.7 59473.7 15564.2 15758.5 15859.2 15865.5 15867.2 11040.6 11043.1 11068.6 11070.5 11313.4 21446.9 22038.2 22038.6 22103.1 22221.6 8210.7 8401.7 8495.2 8548.6 8602.4 999.6 1018.1 1074.7 1112.5 1170.7 30017.5 30029.7 30131.0 30564.1 30783.2 1106.9 1161.4 1164.6 1221.0 1242.4 13604.3 15675.3 15678.5 16060.5 16071.1 349852.0 353227.0 354020.0 354432.0 357164.0 57889.7 58173.7 58189.0 58427.1 58573.4 1481.2 1487.4 1490.4 1493.6 1515.4 31319.1 31345.7 31637.2 31783.4 31793.7 49518.0 49946.8 50048.0 50192.5 50331.7 323859.0 325453.0 326973.0 328909.0 330039.0 30691.8 31192.4 35108.1 36398.3 36636.5 43947.8 45671.0 45790.5 45955.8 46174.8 37673.2 37685.4 38995.8 39151.2 39270.4 33194.8 38098.6 39207.6 39270.6 41687.4 36073.0 36625.5 36861.6 37440.3 41872.6 32617.7 33632.3 34025.8 34260.7 34331.8 25579.5 25601.5 25794.9 28393.6 28824.3 15:20:51 INFO - PROCESS | 7505 | 15:20:51 INFO - PROCESS | 7505 | [#2] jquery.html Cycles:180 Average:28038.27 Median:26439.04 stddev:93806.36 (354.8%) stddev-sans-first:94046.54 15:20:51 INFO - PROCESS | 7505 | Values: 393.3 393.5 394.1 397.5 399.5 12632.6 16624.9 17080.2 17129.4 18390.4 12295.6 12590.0 13411.8 17405.1 17532.5 5238.4 5408.7 5428.7 5432.6 5435.3 5272.4 5340.2 5359.6 5361.2 5363.7 4051.2 4203.8 5311.7 5787.5 5788.2 5601.8 5868.4 5884.3 5892.9 5894.7 5467.8 5629.2 5644.3 5644.6 5662.0 13375.5 13618.8 17879.3 21229.7 21298.1 2147.4 2209.6 2215.8 2257.6 2272.6 9733.4 10092.2 10422.4 10537.4 12715.9 1786.5 1809.0 1941.6 2033.4 2051.8 56979.7 57103.7 57106.4 59507.0 61242.4 9252.2 9579.2 9889.7 10031.8 10089.1 13149.0 13224.7 13265.9 13269.5 13337.7 7274.9 7299.3 7384.3 7404.6 7417.4 7156.0 7160.2 7169.1 7172.2 7211.8 4243.6 4299.3 4342.2 4390.0 4564.3 1768.1 1776.8 1820.2 1876.6 1922.7 496.5 990.3 1015.8 1033.8 1082.8 9502.0 10798.4 10913.2 10963.5 11056.9 489.9 510.7 513.4 520.0 529.4 6457.0 6631.6 6789.2 6822.6 6830.0 561262.0 573452.0 577330.0 578358.0 582841.0 48313.8 48994.5 50187.5 77854.6 79121.6 514.8 517.4 518.2 518.4 520.5 15017.8 15155.2 15633.5 15637.1 16018.4 34936.7 35662.0 36313.8 36436.5 36506.1 42243.0 42773.8 44094.8 44288.1 45068.5 7321.3 7742.9 7889.3 7943.7 7977.5 10583.8 11177.4 11365.5 11654.1 11823.6 10003.3 10019.9 10107.4 10310.5 10450.5 9721.3 10367.5 10432.7 10506.1 10703.5 7407.4 9622.9 9841.3 10009.1 10133.7 7814.3 7836.0 7865.8 7927.2 7950.5 8664.3 9332.6 9624.3 9624.5 9741.7 15:20:51 INFO - PROCESS | 7505 | 15:20:51 INFO - PROCESS | 7505 | [#3] mootools.html Cycles:180 Average:5797.80 Median:7067.58 stddev:2997.03 (42.4%) stddev-sans-first:2988.58 15:20:51 INFO - PROCESS | 7505 | Values: 1568.7 1584.0 1798.2 1884.1 1933.6 7955.8 8152.6 8155.1 8159.3 8168.1 8044.8 8075.8 8078.4 8097.3 8101.8 2417.3 2429.1 2449.6 2459.4 2466.1 2471.0 2477.9 2492.2 2496.8 2497.7 2075.2 2127.4 2130.2 2390.0 2404.8 2337.5 2385.5 2385.7 2405.7 2408.1 2378.5 2391.6 2421.4 2423.8 2425.2 7104.2 7221.4 7632.3 7834.4 8035.3 5068.4 5171.9 5174.1 5180.2 5181.3 3071.6 3099.4 3119.6 3162.5 3166.7 1013.8 1028.5 1044.9 1065.1 1109.7 11429.3 11498.0 11500.9 11519.8 11532.3 4696.3 4711.3 4725.8 4742.1 4769.6 9905.9 9952.8 9975.8 9983.9 9987.6 5132.5 5139.1 5150.5 5158.2 5158.7 4715.9 4717.2 4721.0 4724.8 4728.4 3903.4 3912.6 3928.7 3932.7 3968.4 1257.2 1267.8 1287.5 1290.0 1292.3 1390.6 1456.5 1481.5 1484.6 1498.1 7721.7 7798.9 7811.3 7854.8 7886.9 553.1 557.7 560.4 561.0 562.2 5246.5 6203.4 6234.9 6238.2 6248.5 8677.2 9316.3 9705.1 9713.9 9731.6 9196.7 9532.5 9536.7 9576.8 9579.5 7743.4 7758.6 7798.5 7820.6 7822.3 7380.6 7476.2 7506.1 7509.0 7676.1 8716.2 8880.2 9136.2 9151.1 9164.5 9018.2 9253.3 9273.1 9276.7 9455.2 7419.3 7456.7 7463.3 7498.5 7502.5 7497.4 7590.4 7635.0 7635.1 7636.7 7514.3 7514.8 7579.2 7594.6 7618.0 7505.8 7542.8 7568.2 7654.8 7656.3 7578.6 7764.9 7770.0 7789.8 7790.1 7053.2 7082.0 7091.2 7121.9 7139.3 7170.4 7207.4 7287.5 7310.8 7321.3 15:20:51 INFO - PROCESS | 7505 | 15:20:51 INFO - PROCESS | 7505 | [#4] prototype.html Cycles:180 Average:5339.83 Median:6059.86 stddev:1567.85 (25.9%) stddev-sans-first:1527.31 15:20:51 INFO - PROCESS | 7505 | Values: 374.7 379.7 380.3 384.4 389.2 5968.6 5970.8 5981.8 6007.7 6028.3 5909.4 5932.9 5952.0 5955.3 5966.5 4516.7 4647.6 4651.8 4670.7 4686.6 4646.7 4651.7 4660.6 4663.8 4676.2 4430.0 4516.5 4519.1 4617.9 4624.4 4549.2 4580.5 4581.2 4587.2 4607.9 4019.5 4043.7 4048.8 4055.7 4079.9 5425.7 5546.6 5546.6 5621.1 5663.4 5360.3 5371.8 5375.0 5381.2 5389.9 6330.2 6332.3 6343.8 6344.5 6350.4 4404.6 4512.3 4513.5 4552.3 4555.7 6439.8 6569.9 6573.8 6578.0 6579.6 4614.7 4615.9 4621.3 4632.2 4635.2 4678.9 4686.9 4698.8 4700.3 4704.9 5300.7 5345.0 5432.2 5437.4 5455.3 6333.0 6390.4 6393.0 6393.0 6397.7 1701.7 1719.2 1719.8 1720.6 1720.9 1174.8 1175.7 1196.0 1199.4 1204.4 6092.7 6100.9 6101.6 6110.9 6111.9 6487.5 6502.0 6503.4 6505.2 6510.0 5980.2 6091.5 6092.1 6104.5 6106.1 3475.2 3500.1 3500.2 3503.5 3507.5 6513.6 6661.5 6674.7 6718.9 6729.8 6693.8 6706.2 6734.1 6734.9 6745.9 6759.6 6759.7 6771.8 6773.5 6774.9 6385.3 6498.8 6532.6 6537.1 6540.0 6435.1 6438.2 6441.5 6442.4 6446.1 6749.9 6751.9 6760.0 6761.8 6764.4 4710.4 4711.5 4754.4 4762.4 4783.7 6555.5 6563.1 6565.0 6566.7 6570.8 6344.9 6346.4 6347.2 6348.2 6370.3 6227.4 6375.2 6385.0 6416.7 6420.1 6324.0 6369.5 6372.9 6375.8 6382.3 6437.7 6439.7 6447.0 6447.2 6447.4 6155.9 6281.9 6286.5 6286.9 6288.3 15:20:51 INFO - PROCESS | 7505 | 15:20:51 INFO - PROCESS | 7505 | [#5] yui.html Cycles:180 Average:14733.96 Median:46534.65 stddev:16930.20 (36.4%) stddev-sans-first:16945.96 15:20:51 INFO - PROCESS | 7505 | Values: 929.4 936.4 938.7 944.7 964.0 14332.7 14433.0 14523.0 15909.1 16262.1 14917.8 15005.6 15014.0 15051.6 15084.3 736.3 761.5 910.0 923.1 924.2 891.6 912.8 916.5 919.1 919.8 964.3 964.7 964.9 965.0 965.0 776.5 800.2 938.4 961.6 961.9 695.3 699.1 700.1 700.2 701.7 14461.9 14494.1 14543.9 14544.9 14552.9 13101.5 13527.2 13578.3 13592.5 13632.5 11407.7 11485.3 11558.9 11601.7 11666.6 3849.9 3911.6 3913.6 3914.7 3918.2 51458.5 51912.7 51965.0 52646.5 53106.2 10410.1 10688.3 11236.9 11289.2 11586.8 18874.2 19061.7 19065.8 19071.3 19097.0 7866.4 7868.9 7955.0 8046.7 8142.2 4509.9 4552.0 4591.5 4594.4 4671.1 3194.7 3221.6 3225.9 3232.7 3232.9 577.2 590.8 595.7 599.7 605.1 554.2 659.4 690.4 690.6 737.8 9059.0 9114.7 9288.9 9466.9 9487.0 547.5 569.8 597.7 621.8 669.8 4303.0 4419.2 4453.2 4499.3 4521.2 57560.7 57713.0 57865.4 57875.7 58038.4 52816.2 55100.4 55453.0 55925.0 56209.2 50522.2 53112.7 53491.0 54308.7 54427.0 9551.1 9552.3 9612.7 9708.6 9888.6 33913.5 35124.3 35960.6 36011.5 36234.0 46038.3 46472.3 46597.0 47223.3 47225.8 11532.3 12042.6 12326.7 12633.2 12804.0 11359.3 11451.3 11512.1 11582.5 11899.9 12077.6 12298.9 12433.6 12466.7 12499.9 11534.7 11936.5 12175.5 12298.0 12657.7 11161.5 11482.0 11540.9 11736.2 11847.7 9730.8 9835.9 9991.3 10162.9 10266.2 9875.9 9993.3 10038.4 10403.7 10616.7 15:20:51 INFO - PROCESS | 7505 | -------- Summary: end -------- 15:20:51 INFO - PROCESS | 7505 | 15:20:52 INFO - TEST-INFO | 7505: exit 0 15:20:52 INFO - TEST-OK | dromaeo_css | took 1111380ms 15:20:52 INFO - TEST-START | kraken 15:20:52 INFO - operating with platform_type : linux_ 15:20:52 INFO - Initialising browser for kraken test... 15:20:52 INFO - TEST-INFO | started process 7695 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptNpjZx/profile http://localhost:58010/getInfo.html) 15:20:56 INFO - PROCESS | 7695 | __metrics Screen width/height:1600/1200 15:20:56 INFO - PROCESS | 7695 | colorDepth:24 15:20:56 INFO - PROCESS | 7695 | Browser inner width/height: 1024/697 15:20:56 INFO - PROCESS | 7695 | __metrics 15:20:56 INFO - PROCESS | 7695 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:20:57 INFO - TEST-INFO | 7695: exit 0 15:20:57 INFO - Browser initialized. 15:20:57 INFO - Running cycle 1/1 for kraken test... 15:20:57 INFO - TEST-INFO | started process 7784 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptNpjZx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:09 INFO - PROCESS | 7784 | RSS: Main: 136556544 15:21:09 INFO - PROCESS | 7784 | 15:21:11 INFO - PROCESS | 7784 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58010/tests/kraken/driver.html?testName=audio-beat-detection) 15:21:12 INFO - PROCESS | 7784 | RSS: Main: 170196992 15:21:12 INFO - PROCESS | 7784 | 15:21:15 INFO - PROCESS | 7784 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58010/tests/kraken/driver.html?testName=audio-dft) 15:21:15 INFO - PROCESS | 7784 | RSS: Main: 168800256 15:21:15 INFO - PROCESS | 7784 | 15:21:18 INFO - PROCESS | 7784 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58010/tests/kraken/driver.html?testName=audio-fft) 15:21:18 INFO - PROCESS | 7784 | RSS: Main: 165748736 15:21:18 INFO - PROCESS | 7784 | 15:21:20 INFO - PROCESS | 7784 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58010/tests/kraken/driver.html?testName=audio-oscillator) 15:21:21 INFO - PROCESS | 7784 | RSS: Main: 165736448 15:21:21 INFO - PROCESS | 7784 | 15:21:23 INFO - PROCESS | 7784 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58010/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:21:24 INFO - PROCESS | 7784 | RSS: Main: 164700160 15:21:24 INFO - PROCESS | 7784 | 15:21:27 INFO - PROCESS | 7784 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58010/tests/kraken/driver.html?testName=imaging-darkroom) 15:21:27 INFO - PROCESS | 7784 | RSS: Main: 165728256 15:21:27 INFO - PROCESS | 7784 | 15:21:31 INFO - PROCESS | 7784 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58010/tests/kraken/driver.html?testName=imaging-desaturate) 15:21:31 INFO - PROCESS | 7784 | RSS: Main: 166334464 15:21:31 INFO - PROCESS | 7784 | 15:21:34 INFO - PROCESS | 7784 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58010/tests/kraken/driver.html?testName=json-parse-financial) 15:21:34 INFO - PROCESS | 7784 | RSS: Main: 164966400 15:21:34 INFO - PROCESS | 7784 | 15:21:36 INFO - PROCESS | 7784 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58010/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:21:37 INFO - PROCESS | 7784 | RSS: Main: 168640512 15:21:37 INFO - PROCESS | 7784 | 15:21:38 INFO - PROCESS | 7784 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58010/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:21:39 INFO - PROCESS | 7784 | RSS: Main: 166203392 15:21:39 INFO - PROCESS | 7784 | 15:21:41 INFO - PROCESS | 7784 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58010/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:21:41 INFO - PROCESS | 7784 | RSS: Main: 174383104 15:21:41 INFO - PROCESS | 7784 | 15:21:44 INFO - PROCESS | 7784 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:21:44 INFO - PROCESS | 7784 | RSS: Main: 178012160 15:21:44 INFO - PROCESS | 7784 | 15:21:47 INFO - PROCESS | 7784 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:21:47 INFO - PROCESS | 7784 | RSS: Main: 175693824 15:21:47 INFO - PROCESS | 7784 | 15:21:49 INFO - PROCESS | 7784 | Cycle 1(1): loaded http://localhost:58010/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58010/tests/kraken/driver.html?testName=ai-astar) 15:21:49 INFO - PROCESS | 7784 | RSS: Main: 238276608 15:21:49 INFO - PROCESS | 7784 | 15:21:49 INFO - PROCESS | 7784 | __start_tp_report 15:21:49 INFO - PROCESS | 7784 | _x_x_mozilla_page_load 15:21:49 INFO - PROCESS | 7784 | _x_x_mozilla_page_load_details 15:21:49 INFO - PROCESS | 7784 | |i|pagename|runs| 15:21:49 INFO - PROCESS | 7784 | |0;ai-astar;109;110;104;110;110;110;98;108;108;108 15:21:49 INFO - PROCESS | 7784 | |1;audio-beat-detection;154;125;150;167;125;148;150;126;164;123 15:21:49 INFO - PROCESS | 7784 | |2;audio-dft;160;160;160;161;160;159;159;161;158;160 15:21:49 INFO - PROCESS | 7784 | |3;audio-fft;73;73;72;142;73;73;73;73;145;73 15:21:49 INFO - PROCESS | 7784 | |4;audio-oscillator;95;94;138;94;95;96;134;95;94;145 15:21:49 INFO - PROCESS | 7784 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;108;108;109 15:21:49 INFO - PROCESS | 7784 | |6;imaging-darkroom;146;146;145;145;147;146;146;145;145;144 15:21:49 INFO - PROCESS | 7784 | |7;imaging-desaturate;95;96;96;95;96;96;96;96;95;96 15:21:49 INFO - PROCESS | 7784 | |8;json-parse-financial;53;54;54;54;54;57;54;55;52;53 15:21:49 INFO - PROCESS | 7784 | |9;json-stringify-tinderbox;64;65;63;65;66;65;64;65;65;64 15:21:49 INFO - PROCESS | 7784 | |10;stanford-crypto-aes;78;77;79;79;78;77;77;78;77;78 15:21:49 INFO - PROCESS | 7784 | |11;stanford-crypto-ccm;111;109;112;112;117;126;114;122;112;111 15:21:49 INFO - PROCESS | 7784 | |12;stanford-crypto-pbkdf2;138;148;138;140;140;138;144;144;142;130 15:21:49 INFO - PROCESS | 7784 | |13;stanford-crypto-sha256-iterative;65;65;66;65;64;68;64;66;64;65 15:21:49 INFO - PROCESS | 7784 | __end_tp_report 15:21:49 INFO - PROCESS | 7784 | __start_cc_report 15:21:49 INFO - PROCESS | 7784 | _x_x_mozilla_cycle_collect,945 15:21:49 INFO - PROCESS | 7784 | __end_cc_report 15:21:49 INFO - PROCESS | 7784 | __startTimestamp1457994109892__endTimestamp 15:21:49 INFO - PROCESS | 7784 | 15:21:49 INFO - PROCESS | 7784 | ------- Summary: start ------- 15:21:49 INFO - PROCESS | 7784 | Number of tests: 14 15:21:49 INFO - PROCESS | 7784 | 15:21:49 INFO - PROCESS | 7784 | [#0] ai-astar Cycles:10 Average:107.50 Median:110.00 stddev:3.81 (3.5%) stddev-sans-first:4.00 15:21:49 INFO - PROCESS | 7784 | Values: 109.0 110.0 104.0 110.0 110.0 110.0 98.0 108.0 108.0 108.0 15:21:49 INFO - PROCESS | 7784 | 15:21:49 INFO - PROCESS | 7784 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:150.00 stddev:16.99 (11.3%) stddev-sans-first:17.56 15:21:49 INFO - PROCESS | 7784 | Values: 154.0 125.0 150.0 167.0 125.0 148.0 150.0 126.0 164.0 123.0 15:21:49 INFO - PROCESS | 7784 | 15:21:49 INFO - PROCESS | 7784 | [#2] audio-dft Cycles:10 Average:159.80 Median:160.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 15:21:49 INFO - PROCESS | 7784 | Values: 160.0 160.0 160.0 161.0 160.0 159.0 159.0 161.0 158.0 160.0 15:21:49 INFO - PROCESS | 7784 | 15:21:49 INFO - PROCESS | 7784 | [#3] audio-fft Cycles:10 Average:87.00 Median:73.00 stddev:29.79 (40.8%) stddev-sans-first:31.16 15:21:49 INFO - PROCESS | 7784 | Values: 73.0 73.0 72.0 142.0 73.0 73.0 73.0 73.0 145.0 73.0 15:21:49 INFO - PROCESS | 7784 | 15:21:49 INFO - PROCESS | 7784 | [#4] audio-oscillator Cycles:10 Average:108.00 Median:94.50 stddev:21.56 (22.8%) stddev-sans-first:22.35 15:21:49 INFO - PROCESS | 7784 | Values: 95.0 94.0 138.0 94.0 95.0 96.0 134.0 95.0 94.0 145.0 15:21:49 INFO - PROCESS | 7784 | 15:21:49 INFO - PROCESS | 7784 | [#5] imaging-gaussian-blur Cycles:10 Average:108.80 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:21:49 INFO - PROCESS | 7784 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 108.0 108.0 109.0 15:21:49 INFO - PROCESS | 7784 | 15:21:49 INFO - PROCESS | 7784 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 15:21:49 INFO - PROCESS | 7784 | Values: 146.0 146.0 145.0 145.0 147.0 146.0 146.0 145.0 145.0 144.0 15:21:49 INFO - PROCESS | 7784 | 15:21:49 INFO - PROCESS | 7784 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 15:21:49 INFO - PROCESS | 7784 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 15:21:49 INFO - PROCESS | 7784 | 15:21:49 INFO - PROCESS | 7784 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.33 (2.5%) stddev-sans-first:1.36 15:21:49 INFO - PROCESS | 7784 | Values: 53.0 54.0 54.0 54.0 54.0 57.0 54.0 55.0 52.0 53.0 15:21:49 INFO - PROCESS | 7784 | 15:21:49 INFO - PROCESS | 7784 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.84 (1.3%) stddev-sans-first:0.87 15:21:49 INFO - PROCESS | 7784 | Values: 64.0 65.0 63.0 65.0 66.0 65.0 64.0 65.0 65.0 64.0 15:21:49 INFO - PROCESS | 7784 | 15:21:49 INFO - PROCESS | 7784 | [#10] stanford-crypto-aes Cycles:10 Average:77.80 Median:78.00 stddev:0.79 (1.0%) stddev-sans-first:0.83 15:21:49 INFO - PROCESS | 7784 | Values: 78.0 77.0 79.0 79.0 78.0 77.0 77.0 78.0 77.0 78.0 15:21:49 INFO - PROCESS | 7784 | 15:21:49 INFO - PROCESS | 7784 | [#11] stanford-crypto-ccm Cycles:10 Average:114.60 Median:113.00 stddev:5.46 (4.8%) stddev-sans-first:5.63 15:21:49 INFO - PROCESS | 7784 | Values: 111.0 109.0 112.0 112.0 117.0 126.0 114.0 122.0 112.0 111.0 15:21:49 INFO - PROCESS | 7784 | 15:21:49 INFO - PROCESS | 7784 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.20 Median:141.00 stddev:4.85 (3.4%) stddev-sans-first:5.08 15:21:49 INFO - PROCESS | 7784 | Values: 138.0 148.0 138.0 140.0 140.0 138.0 144.0 144.0 142.0 130.0 15:21:49 INFO - PROCESS | 7784 | 15:21:49 INFO - PROCESS | 7784 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.00 stddev:1.23 (1.9%) stddev-sans-first:1.30 15:21:49 INFO - PROCESS | 7784 | Values: 65.0 65.0 66.0 65.0 64.0 68.0 64.0 66.0 64.0 65.0 15:21:49 INFO - PROCESS | 7784 | -------- Summary: end -------- 15:21:49 INFO - PROCESS | 7784 | 15:21:50 INFO - TEST-INFO | 7784: exit 0 15:21:50 INFO - TEST-OK | kraken | took 58366ms 15:21:50 INFO - TEST-START | v8_7 15:21:50 INFO - operating with platform_type : linux_ 15:21:50 INFO - Initialising browser for v8_7 test... 15:21:50 INFO - TEST-INFO | started process 8039 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4f0XKF/profile http://localhost:58010/getInfo.html) 15:21:55 INFO - PROCESS | 8039 | __metrics Screen width/height:1600/1200 15:21:55 INFO - PROCESS | 8039 | colorDepth:24 15:21:55 INFO - PROCESS | 8039 | Browser inner width/height: 1024/697 15:21:55 INFO - PROCESS | 8039 | __metrics 15:21:55 INFO - PROCESS | 8039 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:21:55 INFO - TEST-INFO | 8039: exit 0 15:21:55 INFO - Browser initialized. 15:21:55 INFO - Running cycle 1/1 for v8_7 test... 15:21:55 INFO - TEST-INFO | started process 8127 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4f0XKF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:22:07 INFO - PROCESS | 8127 | RSS: Main: 136810496 15:22:07 INFO - PROCESS | 8127 | 15:22:30 INFO - PROCESS | 8127 | Cycle 1(1): loaded http://localhost:58010/tests/v8_7/run.html (next: http://localhost:58010/tests/v8_7/run.html) 15:22:30 INFO - PROCESS | 8127 | RSS: Main: 411430912 15:22:30 INFO - PROCESS | 8127 | 15:22:30 INFO - PROCESS | 8127 | __start_tp_report 15:22:30 INFO - PROCESS | 8127 | _x_x_mozilla_page_load 15:22:30 INFO - PROCESS | 8127 | _x_x_mozilla_page_load_details 15:22:30 INFO - PROCESS | 8127 | |i|pagename|runs| 15:22:30 INFO - PROCESS | 8127 | |0;Richards;165.0709805216243 15:22:30 INFO - PROCESS | 8127 | |1;DeltaBlue;169.43409013893594 15:22:30 INFO - PROCESS | 8127 | |2;Encrypt;278.1641168289291 15:22:30 INFO - PROCESS | 8127 | |3;Decrypt;5148.717948717948 15:22:30 INFO - PROCESS | 8127 | |4;RayTrace;955.1098376313277 15:22:30 INFO - PROCESS | 8127 | |5;Earley;546.7468562055768 15:22:30 INFO - PROCESS | 8127 | |6;Boyer;10642.105263157895 15:22:30 INFO - PROCESS | 8127 | |7;RegExp;39711.53846153846 15:22:30 INFO - PROCESS | 8127 | |8;Splay;531.0015898251193 15:22:30 INFO - PROCESS | 8127 | |9;NavierStokes;4840.579710144928 15:22:30 INFO - PROCESS | 8127 | __end_tp_report 15:22:30 INFO - PROCESS | 8127 | __startTimestamp1457994150426__endTimestamp 15:22:30 INFO - PROCESS | 8127 | 15:22:30 INFO - PROCESS | 8127 | ------- Summary: start ------- 15:22:30 INFO - PROCESS | 8127 | Number of tests: 10 15:22:30 INFO - PROCESS | 8127 | 15:22:30 INFO - PROCESS | 8127 | [#0] Richards Cycles:1 Average:165.07 Median:165.07 stddev:0.00 (0.0%) 15:22:30 INFO - PROCESS | 8127 | Values: 165.1 15:22:30 INFO - PROCESS | 8127 | 15:22:30 INFO - PROCESS | 8127 | [#1] DeltaBlue Cycles:1 Average:169.43 Median:169.43 stddev:0.00 (0.0%) 15:22:30 INFO - PROCESS | 8127 | Values: 169.4 15:22:30 INFO - PROCESS | 8127 | 15:22:30 INFO - PROCESS | 8127 | [#2] Encrypt Cycles:1 Average:278.16 Median:278.16 stddev:0.00 (0.0%) 15:22:30 INFO - PROCESS | 8127 | Values: 278.2 15:22:30 INFO - PROCESS | 8127 | 15:22:30 INFO - PROCESS | 8127 | [#3] Decrypt Cycles:1 Average:5148.72 Median:5148.72 stddev:0.00 (0.0%) 15:22:30 INFO - PROCESS | 8127 | Values: 5148.7 15:22:30 INFO - PROCESS | 8127 | 15:22:30 INFO - PROCESS | 8127 | [#4] RayTrace Cycles:1 Average:955.11 Median:955.11 stddev:0.00 (0.0%) 15:22:30 INFO - PROCESS | 8127 | Values: 955.1 15:22:30 INFO - PROCESS | 8127 | 15:22:30 INFO - PROCESS | 8127 | [#5] Earley Cycles:1 Average:546.75 Median:546.75 stddev:0.00 (0.0%) 15:22:30 INFO - PROCESS | 8127 | Values: 546.7 15:22:30 INFO - PROCESS | 8127 | 15:22:30 INFO - PROCESS | 8127 | [#6] Boyer Cycles:1 Average:10642.11 Median:10642.11 stddev:0.00 (0.0%) 15:22:30 INFO - PROCESS | 8127 | Values: 10642.1 15:22:30 INFO - PROCESS | 8127 | 15:22:30 INFO - PROCESS | 8127 | [#7] RegExp Cycles:1 Average:39711.54 Median:39711.54 stddev:0.00 (0.0%) 15:22:30 INFO - PROCESS | 8127 | Values: 39711.5 15:22:30 INFO - PROCESS | 8127 | 15:22:30 INFO - PROCESS | 8127 | [#8] Splay Cycles:1 Average:531.00 Median:531.00 stddev:0.00 (0.0%) 15:22:30 INFO - PROCESS | 8127 | Values: 531.0 15:22:30 INFO - PROCESS | 8127 | 15:22:30 INFO - PROCESS | 8127 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 15:22:30 INFO - PROCESS | 8127 | Values: 4840.6 15:22:30 INFO - PROCESS | 8127 | -------- Summary: end -------- 15:22:30 INFO - PROCESS | 8127 | 15:22:31 INFO - TEST-INFO | 8127: exit 0 15:22:31 INFO - TEST-OK | v8_7 | took 40491ms 15:22:31 INFO - SUITE-END | took 1210s 15:22:31 INFO - Completed test suite (00:20:10) 15:22:31 INFO - Working with test: dromaeo_css 15:22:31 INFO - Generating results file: dromaeo_css 15:22:31 INFO - Working with test: kraken 15:22:31 INFO - Generating results file: kraken 15:22:31 INFO - javascript benchmark 15:22:31 INFO - Working with test: v8_7 15:22:31 INFO - Generating results file: v8_7 15:22:31 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:22:31 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 15:22:31 INFO - process_Request line: dromaeo_css 7042.00 graph.html#tests=[[72,53,35]] 15:22:31 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:22:31 INFO - process_Request line: kraken 1471.90 graph.html#tests=[[232,53,35]] 15:22:31 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 15:22:31 INFO - process_Request line: v8_7 22098.98 graph.html#tests=[[230,53,35]] 15:22:31 INFO - RETURN: dromaeo_css: 7042.00 15:22:31 INFO - RETURN: kraken: 1471.90 15:22:31 INFO - RETURN: v8_7: 22098.98 15:22:31 INFO - javascript benchmark 15:22:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3271.7873338233, 3275.8034517928927, 3307.272400071985, 3308.8511017004216, 3333.1667083229195, 5239.1093514102595, 5239.292695486109, 5252.0, 5267.86830329242, 5303.124984377578, 5228.8692782680455, 5252.212168174776, 5278.841634750964, 5288.418273989868, 5333.813316533922, 4742.668013239075, 4794.208955522335, 4854.4174699036075, 4884.096442158194, 4937.456879743226, 4790.54489823468, 4822.204336284526, 4823.758812059401, 4825.469198388192, 4832.565069143777, 4768.165571025074, 4774.880627984294, 4828.082664293791, 4831.492693267209, 4870.464248932614, 4853.611711063107, 4923.556879880792, 4924.704517728947, 4926.9014619707405, 4952.678075925053, 4856.514348565151, 4863.319135321058, 4885.43817460993, 4890.951090489085, 4894.241392584119, 4973.303737476756, 5068.163752980754, 5074.391073071255, 5129.025485157808, 5155.046316431472, 5572.637778544422, 5611.635243709186, 5637.154426836008, 5664.688442135681, 5731.684757338345, 5724.198612194296, 5756.769729210827, 5760.423957604248, 5766.913496297559, 5771.797987070474, 5154.304168937183, 5219.791208351661, 5308.893822123575, 5330.093884039723, 5330.706811125387, 5723.313202415654, 5761.107028410603, 5763.164341170591, 5768.653880767168, 5775.48020678141, 5574.916376254359, 5578.079616863253, 5580.497755202051, 5581.274434323512, 5597.328320601554, 5386.299781028441, 5447.0, 5612.382637909826, 5653.547716182696, 5674.744636491368, 5593.300837395325, 5612.0, 5632.85917852057, 5649.209110724501, 5654.943450565442, 5607.299087614048, 5651.8304450866535, 5662.094064949588, 5670.773169073191, 5680.77276908919, 4231.809568569422, 4252.85115020979, 4292.248856450109, 4313.2883074292395, 4314.352847072902, 3923.8822835314986, 3961.3265744822875, 3961.4255932890146, 3967.3255546557157, 3983.9203215935518, 5199.688018718889, 5277.63056586043, 5302.522772950453, 5304.257403963448, 5305.4164041955355, 5449.455054494519, 5598.86002849932, 5612.494875461228, 5623.240862483594, 5658.519025882763, 5186.455422180692, 5203.791848326025, 5214.0875346814155, 5224.190250511177, 5241.737913104405, 4743.430788305425, 4790.137775200427, 4804.399450068741, 4812.590929770939, 4837.153498137812, 5722.456366645162, 5743.798967036134, 5762.337331206881, 5762.654240745569, 5809.477147056785, 5610.326760788732, 5647.265855438766, 5659.6321239119325, 5669.546436285004, 5673.205751194753, 5694.886102278014, 5714.457126572969, 5729.856753581027, 5787.5369970401425, 5809.30288365382, 5529.253550770594, 5607.41122182165, 5614.803481878114, 5627.634203776742, 5644.379118296902, 5576.470235327637, 5580.302462192226, 5585.69278689676, 5585.860353491195, 5586.748596313095, 5402.702851343057, 5429.484199001088, 5458.6724796512335, 5487.0, 5489.3687225969525, 5461.1262198048125, 5463.644863083887, 5463.72681365938, 5476.808311709071, 5490.149026900836, 5338.0, 5343.118385466354, 5345.0, 5352.866178345416, 5419.83740487786, 5448.155535891943, 5453.7818487260065, 5476.069068258326, 5511.145772405283, 5520.503154715934, 5414.187871819258, 5459.454054594509, 5459.781608735606, 5464.3442786865835, 5466.125419932791], "unit": "score", "name": "dojo.html", "value": 5200.754584092484}, {"lowerIsBetter": false, "replicates": [553.7895599672124, 554.8335499350196, 571.2858926342074, 580.8054301808894, 597.9252593425822, 30532.542011869813, 31121.221969450777, 31128.68871311289, 38728.612713872855, 39500.60499395005, 41577.7921110394, 41888.79055604725, 41987.37018944718, 42065.78967105168, 42099.78950105253, 8843.159899809507, 9042.909570904272, 9053.230475409599, 9054.818903621923, 9069.0, 8716.912830871705, 8895.0, 8919.866202006942, 8927.151920567569, 8935.463872167658, 8880.911190888106, 8942.329325300596, 8957.641694332218, 8958.059403762609, 8958.104189581056, 9020.052894446088, 9094.77263068422, 9107.180353768194, 9121.0, 9140.131687489711, 8909.242714369286, 8986.820263594756, 9057.818843623156, 9071.682491112779, 9077.409968352036, 42315.57684423178, 42672.78663606693, 42783.0, 42926.0, 42960.570394295966, 3768.152165762709, 3784.375578029622, 3833.4824798652103, 3846.0209917543066, 3934.173823497069, 32777.672223277936, 32949.341013179604, 32986.34027319464, 33207.667923320696, 37335.4399684005, 4034.4553485279407, 4078.082431452929, 4111.09555897702, 4116.320403865376, 4136.565660605623, 301870.0, 306058.0, 306152.0, 307443.0, 307890.0, 57816.71091644515, 59773.70113149406, 66216.0, 66591.66704166448, 68900.65549672219, 58841.70579147077, 59018.70490647519, 59153.704231478565, 59390.70304648535, 59473.702631486565, 15564.221788910509, 15758.527244182693, 15859.207039647972, 15865.52403427899, 15867.206639668202, 11040.613578524713, 11043.116550675926, 11068.612598559012, 11070.501827417786, 11313.377764222882, 21446.892765536384, 22038.228661996753, 22038.559228815335, 22103.115875365125, 22221.555568888532, 8210.712625058095, 8401.663933442594, 8495.192956669107, 8548.572571371407, 8602.354823388147, 999.5983756526407, 1018.0786388318584, 1074.6990842564094, 1112.4882554025078, 1170.666360087371, 30017.549736753965, 30029.699703003127, 30131.0, 30564.083077507712, 30783.23041923925, 1106.900378965881, 1161.4134861894688, 1164.6273192578462, 1220.9987809995896, 1242.4409015942863, 13604.319784010957, 15675.29461174227, 15678.451254206277, 16060.51238070538, 16071.11608861524, 349852.0, 353227.0, 354020.0, 354432.0, 357164.0, 57889.71055144782, 58173.70913145492, 58189.0, 58427.123593146134, 58573.414265857646, 1481.2445652717192, 1487.3976039704153, 1490.3814916809404, 1493.57433131557, 1515.3786947351532, 31319.06042818719, 31345.686543134278, 31637.20906977344, 31783.364332713678, 31793.682063179072, 49518.0, 49946.75026624989, 50048.0, 50192.498075020245, 50331.74834125806, 323859.0, 325453.0, 326973.0, 328909.0, 330039.0, 30691.846540767154, 31192.37615247637, 35108.12229694278, 36398.27203455969, 36636.45045324376, 43947.78026109977, 45671.0, 45790.542094578625, 45955.77022114868, 46174.769126154155, 37673.246535069695, 37685.4347184787, 38995.805020974716, 39151.2169756609, 39270.4109438353, 33194.83402582972, 38098.619013809504, 39207.6079239204, 39270.607293926696, 41687.374689379074, 36073.0, 36625.45061824128, 36861.631383686894, 37440.251194975404, 41872.58127418809, 32617.673823262412, 33632.327353453285, 34025.82987085049, 34260.65739342575, 34331.79838705633, 25579.48841023132, 25601.48797024012, 25794.871025644752, 28393.574096388984, 28824.279393014505], "unit": "score", "name": "ext.html", "value": 19552.190408156042}, {"lowerIsBetter": false, "replicates": [393.2547821877542, 393.54545499947534, 394.1230761555539, 397.52098721041165, 399.53254692010347, 12632.62102136935, 16624.91687541562, 17080.23138958747, 17129.400470983503, 18390.448286551426, 12295.569655062074, 12590.0, 13411.798823017663, 17405.129743512807, 17532.474025779247, 5238.371395432544, 5408.702521361323, 5428.701421421821, 5432.619716619838, 5435.266239057736, 5272.420033796279, 5340.225667278242, 5359.5712343012665, 5361.249425080492, 5363.731813409334, 4051.230266249418, 4203.810828512725, 5311.654742441749, 5787.450192231752, 5788.218590490293, 5601.775928962837, 5868.41315868414, 5884.293884733816, 5892.882142357172, 5894.705264736789, 5467.824417750203, 5629.211910332516, 5644.322681278232, 5644.604877658566, 5662.037453632893, 13375.531856385078, 13618.795718064237, 17879.28482860684, 21229.68155477669, 21298.148074077017, 2147.387994421598, 2209.6464565669576, 2215.8448908576406, 2257.582347265761, 2272.625016872231, 9733.367331123454, 10092.243081768824, 10422.426766527838, 10537.367757934471, 12715.87284127156, 1786.5444311700433, 1808.97286540702, 1941.6116776644728, 2033.4408037789578, 2051.7845626209332, 56979.71510142464, 57103.71448142733, 57106.428935710945, 59507.0, 61242.38757612456, 9252.213561847184, 9579.233661307078, 9889.653862114792, 10031.849522257173, 10089.142422894136, 13149.0, 13224.669383265495, 13265.867341326657, 13269.469221231042, 13337.73324533504, 7274.927250727531, 7299.343059124704, 7384.26157384268, 7404.629768511553, 7417.443691723142, 7156.0, 7160.176579693298, 7169.068021157216, 7172.175199851979, 7211.783646490614, 4243.554426785205, 4299.333603291495, 4342.240107981091, 4390.012247244408, 4564.315352697122, 1768.1295605565385, 1776.8223177682128, 1820.162725146421, 1876.6434377468238, 1922.6827573450223, 496.4762175904456, 990.301837204769, 1015.8374660054355, 1033.8087453821067, 1082.8375743638517, 9502.0, 10798.352098874093, 10913.23607347478, 10963.451827408757, 11056.889431105747, 489.89712160446703, 510.6757209172128, 513.4382590493499, 519.9714015729096, 529.4149964289405, 6456.967715161394, 6631.602103873686, 6789.1852977643, 6822.624755638389, 6829.975503674488, 561262.0, 573452.0, 577330.0, 578358.0, 582841.0, 48313.75843120832, 48994.51005489971, 50187.49812501901, 77854.61072694714, 79121.60439197767, 514.8018013064997, 517.4411635433722, 518.2381898609113, 518.4116028307898, 520.5029197116744, 15017.77473337879, 15155.242237888282, 15633.530994070195, 15637.061776293458, 16018.439354622533, 34936.650633494355, 35662.0, 36313.818430907675, 36436.45345319769, 36506.087347816516, 42243.0, 42773.786131069144, 44094.77952610217, 44288.11423771571, 45068.54931450643, 7321.304476074764, 7742.883856742041, 7889.289963903277, 7943.682252709827, 7977.521348718863, 10583.788324233627, 11177.385243811668, 11365.48855301497, 11654.125940554663, 11823.645290641294, 10003.34978226413, 10019.899801001897, 10107.39355638664, 10310.484475776331, 10450.529726162493, 9721.319507634398, 10367.533460994122, 10432.68701938943, 10506.106980906708, 10703.518341674488, 7407.407407407502, 9622.855657165008, 9841.311108222355, 10009.099181073447, 10133.695989120339, 7814.257645523666, 7835.960820195863, 7865.842683146419, 7927.207279272026, 7950.4832185907735, 8664.263537599374, 9332.626694932127, 9624.326297159412, 9624.51877406141, 9741.707748767549], "unit": "score", "name": "jquery.html", "value": 7765.289947932909}, {"lowerIsBetter": false, "replicates": [1568.7097886890924, 1583.952481425557, 1798.181827268593, 1884.0768023668406, 1933.632609804138, 7955.840883182333, 8152.633131509081, 8155.143709910463, 8159.306458950981, 8168.101508834031, 8044.8391032179325, 8075.757727268191, 8078.434509584332, 8097.2712455878955, 8101.756947291576, 2417.2506522977933, 2429.1255148146697, 2449.5713250181147, 2459.434330104077, 2466.05057053035, 2470.950580988379, 2477.938051548708, 2492.22740950306, 2496.8377055491424, 2497.7377375375595, 2075.2321640992777, 2127.393692797553, 2130.1585873579925, 2390.032037025008, 2404.843685160468, 2337.5208082343165, 2385.5348207099623, 2385.666006759055, 2405.7353691093967, 2408.14510848648, 2378.4767351182713, 2391.629297458897, 2421.406755344934, 2423.7697418745192, 2425.199684104259, 7104.183018952835, 7221.350078492961, 7632.313091821763, 7834.373250140032, 8035.276825085712, 5068.3917929848285, 5171.896562068738, 5174.094533456668, 5180.222966555047, 5181.326427564431, 3071.616047994001, 3099.3801239751915, 3119.5632611434417, 3162.4623813951684, 3166.651668316483, 1013.8276492996134, 1028.5268776362882, 1044.8850626431085, 1065.0733861540432, 1109.7114750164935, 11429.257098288585, 11497.999999999916, 11500.884991150066, 11519.827202591969, 11532.308061516336, 4696.272077827942, 4711.316859055418, 4725.834595789131, 4742.099001189763, 4769.642276829251, 9905.851412228822, 9952.80094398108, 9975.800483990279, 9983.850242246372, 9987.60049598008, 5132.461091585405, 5139.12634852076, 5150.536451719363, 5158.174692049254, 5158.690478571298, 4715.882102947385, 4717.22165842639, 4721.032188401369, 4724.811007559659, 4728.40894888139, 3903.375459926398, 3912.550056743454, 3928.705347098979, 3932.6853851691794, 3968.40473928913, 1257.1702676233824, 1267.8034904589804, 1287.5429222626021, 1289.9677508062373, 1292.2892409174917, 1390.5967269491734, 1456.5266288456294, 1481.525911708243, 1484.5620541940154, 1498.1460567476433, 7721.727367222188, 7798.883016754753, 7811.336036436853, 7854.803629909298, 7886.881696774553, 553.0956885492249, 557.736726314897, 560.4311623701946, 561.0238185557101, 562.2409746841813, 5246.475352464723, 6203.441690247809, 6234.875302493925, 6238.220222472191, 6248.5313601480075, 8677.1756683115, 9316.301277404222, 9705.078017588317, 9713.854292185622, 9731.610735570639, 9196.678116266032, 9532.52337383128, 9536.666216682383, 9576.760580985392, 9579.521023948775, 7743.419243556756, 7758.612069396508, 7798.53208807462, 7820.553197658452, 7822.335101516434, 7380.630968451448, 7476.177620461854, 7506.061742282215, 7508.962455187689, 7676.078870535572, 8716.215540601377, 8880.200781929658, 9136.223421009288, 9151.084891510796, 9164.541772911462, 9018.241442918568, 9253.259739220712, 9273.119053689888, 9276.675316364164, 9455.243580513405, 7419.332260096618, 7456.664450099867, 7463.328300452768, 7498.512596681198, 7502.474826762293, 7497.437692173218, 7590.430717696085, 7635.00744903159, 7635.121960974337, 7636.694532218871, 7514.323710866049, 7514.812129696583, 7579.204183560647, 7594.6202689866395, 7617.961910190414, 7505.774826755206, 7542.773716788505, 7568.205338439385, 7654.8086297843, 7656.310932016146, 7578.621068946641, 7764.88352674699, 7770.0, 7789.805254868447, 7790.1041380241995, 7053.188883278283, 7081.964590177016, 7091.184513780981, 7121.857562848818, 7139.286071392819, 7170.39051680613, 7207.351338379571, 7287.453440991841, 7310.817229569303, 7321.304476074764], "unit": "score", "name": "mootools.html", "value": 4707.336153963203}, {"lowerIsBetter": false, "replicates": [374.73768362146495, 379.74557046778654, 380.3458052150301, 384.40417353102686, 389.23515292450327, 5968.641881487109, 5970.761169553223, 5981.820545383645, 6007.669578173204, 6028.276606807184, 5909.433999990006, 5932.851678708034, 5952.047672372421, 5955.315138759044, 5966.46301832835, 4516.661250406224, 4647.60495357895, 4651.837185698484, 4670.696404733699, 4686.601638860701, 4646.744429056401, 4651.7441540715245, 4660.580547750702, 4663.7668116594205, 4676.228422310314, 4430.0, 4516.525764794698, 4519.118771839492, 4617.884552886171, 4624.352590637297, 4549.181147393468, 4580.450345958473, 4581.221192397284, 4587.174308624446, 4607.884802879921, 4019.4573732546023, 4043.696722745806, 4048.838046478137, 4055.655269302113, 4079.938800917989, 5425.728713564306, 5546.611737178399, 5546.613346663335, 5621.072523033695, 5663.405342439067, 5360.2763626910255, 5371.811986580451, 5374.973125134388, 5381.192821076831, 5389.865253368697, 6330.17707698001, 6332.335104813974, 6343.777967771152, 6344.524160687921, 6350.428461438447, 4404.581564751344, 4512.323151527265, 4513.480949690795, 4552.271636538138, 4555.726656400627, 6439.83900402489, 6569.868602627921, 6573.769918052845, 6578.046183303442, 6579.572327798725, 4614.676972611885, 4615.9076818463445, 4621.260598304255, 4632.235681112578, 4635.1656701794, 4678.906421871544, 4686.906261874743, 4698.812047518061, 4700.341952126705, 4704.882377940579, 5300.655457395257, 5345.037893179187, 5432.185172224119, 5437.401885792559, 5455.290812194468, 6332.968335158294, 6390.360963903572, 6392.968035159794, 6393.041043843367, 6397.7440902364315, 1701.6766814305242, 1719.17479609788, 1719.75063615775, 1720.6128621060411, 1720.8537274331823, 1174.8061569841052, 1175.6590588729173, 1195.9581414650445, 1199.3823181061587, 1204.3616883051996, 6092.69536523181, 6100.908486372708, 6101.633901965896, 6110.877782444326, 6111.908321375183, 6487.513436492282, 6502.0, 6503.447206987459, 6505.154329937078, 6510.0, 5980.192673989043, 6091.451769340781, 6092.116643086728, 6104.542159338067, 6106.145139680449, 3475.2354482013916, 3500.0899766061007, 3500.1599616091953, 3503.4569641705575, 3507.4563442666426, 6513.576617519846, 6661.467082633378, 6674.699638516181, 6718.93281067183, 6729.798106056826, 6693.765718199839, 6706.195256569145, 6734.124563806674, 6734.932650673529, 6745.898811517831, 6759.5606285591275, 6759.695813688396, 6771.796846094625, 6773.5258531904265, 6774.864502709918, 6385.329540398191, 6498.772542961163, 6532.608043517404, 6537.084808126771, 6539.967300163468, 6435.099086127852, 6438.163038804925, 6441.516886233458, 6442.387973142544, 6446.129772480843, 6749.898751518829, 6751.93248067513, 6759.966200168968, 6761.830954226184, 6764.3573860483175, 4710.4347478302825, 4711.481737008995, 4754.381930349033, 4762.4285085789925, 4783.6651434399255, 6555.475561955128, 6563.0811686364905, 6565.0, 6566.737330506726, 6570.8357291068105, 6344.873102537831, 6346.365363463801, 6347.238331400077, 6348.238211414659, 6370.26741924666, 6227.439530442282, 6375.203099612549, 6384.968075159594, 6416.711247993945, 6420.101185833893, 6323.9683801580695, 6369.49044076482, 6372.936270637234, 6375.776847810304, 6382.32985536512, 6437.742490300336, 6439.67801609927, 6447.0, 6447.2263328400895, 6447.4197322241225, 6155.938440615716, 6281.874362512815, 6286.465650419583, 6286.874262514632, 6288.308286088435], "unit": "score", "name": "prototype.html", "value": 4852.292292062883}, {"lowerIsBetter": false, "replicates": [929.3587424676973, 936.4240991790049, 938.6667732954801, 944.6504793226503, 964.0263334032625, 14332.713345733078, 14432.98969072164, 14523.0, 15909.124998125099, 16262.105584192865, 14917.776233356508, 15005.624859378493, 15014.0, 15051.62370940727, 15084.32120554575, 736.2821249281934, 761.4555592751182, 909.9545022748853, 923.1276443760648, 924.2144177449181, 891.5854127830557, 912.803747194353, 916.5371487398854, 919.0717375450776, 919.8252332056887, 964.2816102004017, 964.7154089543601, 964.9372790768613, 964.9517524123801, 965.0205041882494, 776.5185584937318, 800.2237829305535, 938.3759799733169, 961.6153538584553, 961.889382720989, 695.3185877839745, 699.136566340569, 700.1178515070997, 700.1528150937372, 701.6877489517167, 14461.927690361586, 14494.130352178903, 14543.927280363636, 14544.854551454457, 14552.92723536386, 13101.47594096235, 13527.18836869781, 13578.321083945862, 13592.456301747918, 13632.454701812016, 11407.714807129805, 11485.253458525169, 11558.942205289004, 11601.709957251136, 11666.59166929162, 3849.8845034649007, 3911.6479516843337, 3913.62820532049, 3914.745541539791, 3918.216356728637, 51458.48541514574, 51912.74043629796, 51964.96070078615, 52646.47353526454, 53106.203406948924, 10410.063094321547, 10688.25182237236, 11236.887631123747, 11289.209755317213, 11586.76826463466, 18874.15066322019, 19061.714074288895, 19065.809341906403, 19071.332503362315, 19097.0, 7866.449348545661, 7868.921310786819, 7954.960225198953, 8046.678132874737, 8142.226488483585, 4509.932351014738, 4551.954480455153, 4591.47198072226, 4594.448666160082, 4671.11248862715, 3194.6805319467867, 3221.597300337458, 3225.903222903317, 3232.725218356419, 3232.870685172567, 577.2466930655451, 590.7725525672647, 595.6604735300923, 599.6701814002369, 605.1195510532253, 554.206797739389, 659.350539718377, 690.3959035843637, 690.6063543779998, 737.8413641067197, 9059.048799876049, 9114.726558203265, 9288.860667089999, 9466.85455640916, 9487.003864594257, 547.4853637580661, 569.814810186691, 597.7280337446451, 621.8283535906114, 669.7689297192461, 4302.9569704303185, 4419.18245124653, 4453.242948698729, 4499.257622492318, 4521.208788462006, 57560.71219643875, 57713.0, 57865.421345786, 57875.71062144746, 58038.4196158033, 52816.20775688291, 55100.448995509534, 55453.0, 55925.0, 56209.15686264709, 50522.242166367534, 53112.73443632834, 53491.0, 54308.728456357465, 54427.0, 9551.0926461986, 9552.331336806357, 9612.66355677548, 9708.563114659999, 9888.604455821687, 33913.49129763105, 35124.29751404907, 35960.64039359573, 36011.45982810207, 36234.0, 46038.30942535798, 46472.302915456974, 46597.0, 47223.29165062596, 47225.763871180425, 11532.25040372373, 12042.578509752117, 12326.691832704255, 12633.2420054797, 12803.975681945236, 11359.318440893572, 11451.25566838153, 11512.136589755635, 11582.478788454708, 11899.940500297444, 12077.57728479499, 12298.877011229773, 12433.626991190278, 12466.68833279139, 12499.93750031244, 11534.711632208926, 11936.462859171532, 12175.45210465549, 12298.0, 12657.683557911127, 11161.49773260189, 11482.0, 11540.859330191333, 11736.237144585575, 11847.70380740454, 9730.805383892424, 9835.901640983784, 9991.318367853157, 10162.949185254027, 10266.178705703376, 9875.901240987498, 9993.250506212209, 10038.444255828932, 10403.687889363331, 10616.734581635521], "unit": "score", "name": "yui.html", "value": 6760.779241233401}], "name": "dromaeo_css", "value": 7041.999609836281}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 110.0, 104.0, 110.0, 110.0, 110.0, 98.0, 108.0, 108.0, 108.0], "unit": "score", "name": "ai-astar", "value": 107.5}, {"lowerIsBetter": true, "replicates": [154.0, 125.0, 150.0, 167.0, 125.0, 148.0, 150.0, 126.0, 164.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 143.2}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 161.0, 160.0, 159.0, 159.0, 161.0, 158.0, 160.0], "unit": "score", "name": "audio-dft", "value": 159.8}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 142.0, 73.0, 73.0, 73.0, 73.0, 145.0, 73.0], "unit": "score", "name": "audio-fft", "value": 87.0}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 138.0, 94.0, 95.0, 96.0, 134.0, 95.0, 94.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 108.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 108.0, 108.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 108.8}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 145.0, 147.0, 146.0, 146.0, 145.0, 145.0, 144.0], "unit": "score", "name": "imaging-darkroom", "value": 145.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [53.0, 54.0, 54.0, 54.0, 54.0, 57.0, 54.0, 55.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.0}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 63.0, 65.0, 66.0, 65.0, 64.0, 65.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [78.0, 77.0, 79.0, 79.0, 78.0, 77.0, 77.0, 78.0, 77.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 77.8}, {"lowerIsBetter": true, "replicates": [111.0, 109.0, 112.0, 112.0, 117.0, 126.0, 114.0, 122.0, 112.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.6}, {"lowerIsBetter": true, "replicates": [138.0, 148.0, 138.0, 140.0, 140.0, 138.0, 144.0, 144.0, 142.0, 130.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.2}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 65.0, 64.0, 68.0, 64.0, 66.0, 64.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.2}], "name": "kraken", "value": 1471.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.0709805216243], "unit": "score", "name": "Richards", "value": 213.85951599999999}, {"lowerIsBetter": false, "replicates": [169.43409013893594], "unit": "score", "name": "DeltaBlue", "value": 390.228436}, {"lowerIsBetter": false, "replicates": [278.1641168289291], "unit": "score", "name": "Encrypt", "value": 956.9206949999998}, {"lowerIsBetter": false, "replicates": [5148.717948717948], "unit": "score", "name": "Decrypt", "value": 51.69850099601596}, {"lowerIsBetter": false, "replicates": [955.1098376313277], "unit": "score", "name": "RayTrace", "value": 774.7684829999998}, {"lowerIsBetter": false, "replicates": [546.7468562055768], "unit": "score", "name": "Earley", "value": 1218.960827}, {"lowerIsBetter": false, "replicates": [10642.105263157895], "unit": "score", "name": "Boyer", "value": 62.62510880316516}, {"lowerIsBetter": false, "replicates": [39711.53846153846], "unit": "score", "name": "RegExp", "value": 22.94005811138016}, {"lowerIsBetter": false, "replicates": [531.0015898251193], "unit": "score", "name": "Splay", "value": 153.46658383233535}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 22098.97869090429}]} 15:22:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "22098.98"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1471.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7042.00"}}} 15:22:31 INFO - Return code: 0 15:22:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 15:22:31 INFO - # TBPL SUCCESS # 15:22:31 INFO - Running post-action listener: _resource_record_post_action 15:22:31 INFO - Running post-run listener: _resource_record_post_run 15:22:32 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 3411968; Write bytes: 228605952; Read time: 308; Write time: 119292 15:22:32 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 4657152; Read time: 0; Write time: 312 15:22:32 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 3411968; Write bytes: 223948800; Read time: 308; Write time: 118980 15:22:32 INFO - Running post-run listener: _upload_blobber_files 15:22:32 INFO - Blob upload gear active. 15:22:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 15:22:32 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:22:32 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:22:32 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:22:33 INFO - (blobuploader) - INFO - Open directory for files ... 15:22:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 15:22:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:22:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:34 INFO - (blobuploader) - INFO - Done attempting. 15:22:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:22:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:22:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:22:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:22:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:22:35 INFO - (blobuploader) - INFO - Done attempting. 15:22:35 INFO - (blobuploader) - INFO - Iteration through files over. 15:22:35 INFO - Return code: 0 15:22:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 15:22:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 15:22:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/edd7d39f69e80259bab77059b9dd401d49c44613a93bf83a46f88f05fad678219b55772392aa7a559713a87cc8607f58e495138273f391bea8510f4cbaeaeb98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a39b54446559f46a239dd701a8eabdf59814e36130add93a664988f6e6c83a497c2800a38d49c8be461d7796f6e5fac7dffe7a7feeca7438d8fda5fe68f05b54"} 15:22:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 15:22:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 15:22:35 INFO - Contents: 15:22:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/edd7d39f69e80259bab77059b9dd401d49c44613a93bf83a46f88f05fad678219b55772392aa7a559713a87cc8607f58e495138273f391bea8510f4cbaeaeb98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a39b54446559f46a239dd701a8eabdf59814e36130add93a664988f6e6c83a497c2800a38d49c8be461d7796f6e5fac7dffe7a7feeca7438d8fda5fe68f05b54"} 15:22:35 INFO - Running post-run listener: copy_logs_to_upload_dir 15:22:35 INFO - Copying logs to upload dir... 15:22:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 15:22:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.179480 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-14 15:22:35.336020) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 15:22:35.340167) ========= 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=574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315 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/edd7d39f69e80259bab77059b9dd401d49c44613a93bf83a46f88f05fad678219b55772392aa7a559713a87cc8607f58e495138273f391bea8510f4cbaeaeb98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a39b54446559f46a239dd701a8eabdf59814e36130add93a664988f6e6c83a497c2800a38d49c8be461d7796f6e5fac7dffe7a7feeca7438d8fda5fe68f05b54"} build_url:https://queue.taskcluster.net/v1/task/V2cj4JNvQpOEHfT-iru2tg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011285 build_url: 'https://queue.taskcluster.net/v1/task/V2cj4JNvQpOEHfT-iru2tg/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/edd7d39f69e80259bab77059b9dd401d49c44613a93bf83a46f88f05fad678219b55772392aa7a559713a87cc8607f58e495138273f391bea8510f4cbaeaeb98", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a39b54446559f46a239dd701a8eabdf59814e36130add93a664988f6e6c83a497c2800a38d49c8be461d7796f6e5fac7dffe7a7feeca7438d8fda5fe68f05b54"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-14 15:22:35.369446) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 15:22:35.369831) ========= 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=574dc5aafe09851ec43d388c000001b6-1457991736.140580-1019429315 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004457 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-14 15:22:35.452742) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 15:22:35.453068) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-14 15:22:35.453414) ========= ========= Total master_lag: 0.32 =========