builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1456655351.23 results: success (0) buildid: 20160227030340 builduid: ef20964ffb474f23ad057cd8a79c37a7 revision: b5df3e5a52c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.234191) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.234588) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.235111) ========= 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=8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007613 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.329496) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.329812) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.594652) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.595000) ========= 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=8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.040819 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.651786) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.652131) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.652540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.652846) ========= 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=8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-28 02:29:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.0M=0s 2016-02-28 02:29:11 (34.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.225372 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.889606) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:11.889922) ========= 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=8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.295848 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:12.199546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:12.199982) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b5df3e5a52c8 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b5df3e5a52c8 --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=8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-28 02:29:12,273 Setting DEBUG logging. 2016-02-28 02:29:12,273 attempt 1/10 2016-02-28 02:29:12,273 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b5df3e5a52c8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-28 02:29:12,724 unpacking tar archive at: mozilla-aurora-b5df3e5a52c8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.763795 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:12.976063) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:12.976417) ========= echo b5df3e5a52c8 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b5df3e5a52c8'] 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=8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b5df3e5a52c8 program finished with exit code 0 elapsedTime=0.004321 script_repo_revision: 'b5df3e5a52c8' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:13.026654) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:13.027000) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-28 02:29:13.041319) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2016-02-28 02:29:13.041626) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:29:13 INFO - MultiFileLogger online at 20160228 02:29:13 in /builds/slave/test-pgo 02:29:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:29:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:29:13 INFO - {'append_to_log': False, 02:29:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:29:13 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:29:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:29:13 INFO - 'branch': 'Mozilla-Aurora', 02:29:13 INFO - 'buildbot_json_path': 'buildprops.json', 02:29:13 INFO - 'config_files': ('talos/linux_config.py',), 02:29:13 INFO - 'default_actions': ('clobber', 02:29:13 INFO - 'read-buildbot-config', 02:29:13 INFO - 'download-and-extract', 02:29:13 INFO - 'populate-webroot', 02:29:13 INFO - 'create-virtualenv', 02:29:13 INFO - 'install', 02:29:13 INFO - 'run-tests'), 02:29:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:29:13 INFO - 'download_minidump_stackwalk': True, 02:29:13 INFO - 'download_symbols': 'ondemand', 02:29:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:29:13 INFO - 'tooltool.py': '/tools/tooltool.py', 02:29:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:29:13 INFO - '/tools/misc-python/virtualenv.py')}, 02:29:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:29:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:29:13 INFO - 'installer_path': 'installer.exe', 02:29:13 INFO - 'log_level': 'info', 02:29:13 INFO - 'log_name': 'talos', 02:29:13 INFO - 'log_to_console': True, 02:29:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:29:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:29:13 INFO - 'opt_config_files': (), 02:29:13 INFO - 'pip_index': False, 02:29:13 INFO - 'sps_profile': False, 02:29:13 INFO - 'sps_profile_interval': 0, 02:29:13 INFO - 'suite': 'dromaeojs', 02:29:13 INFO - 'system_bits': '32', 02:29:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:29:13 INFO - 'title': 'talos-linux64-ix-038', 02:29:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:29:13 INFO - 'use_talos_json': True, 02:29:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:29:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:29:13 INFO - 'work_dir': 'build'} 02:29:13 INFO - ##### 02:29:13 INFO - ##### Running clobber step. 02:29:13 INFO - ##### 02:29:13 INFO - Running pre-action listener: _resource_record_pre_action 02:29:13 INFO - Running main action method: clobber 02:29:13 INFO - rmtree: /builds/slave/test-pgo/build 02:29:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:29:14 INFO - Running post-action listener: _resource_record_post_action 02:29:14 INFO - ##### 02:29:14 INFO - ##### Running read-buildbot-config step. 02:29:14 INFO - ##### 02:29:14 INFO - Running pre-action listener: _resource_record_pre_action 02:29:14 INFO - Running main action method: read_buildbot_config 02:29:14 INFO - Using buildbot properties: 02:29:14 INFO - { 02:29:14 INFO - "project": "", 02:29:14 INFO - "product": "firefox", 02:29:14 INFO - "script_repo_revision": "production", 02:29:14 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:29:14 INFO - "repository": "", 02:29:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:29:14 INFO - "buildid": "20160227030340", 02:29:14 INFO - "pgo_build": "True", 02:29:14 INFO - "basedir": "/builds/slave/test-pgo", 02:29:14 INFO - "buildnumber": 185, 02:29:14 INFO - "slavename": "talos-linux64-ix-038", 02:29:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:29:14 INFO - "platform": "ubuntu64_hw", 02:29:14 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:29:14 INFO - "branch": "mozilla-aurora", 02:29:14 INFO - "repo_path": "releases/mozilla-aurora", 02:29:14 INFO - "revision": "b5df3e5a52c8", 02:29:14 INFO - "stage_platform": "linux64-pgo", 02:29:14 INFO - "builduid": "ef20964ffb474f23ad057cd8a79c37a7", 02:29:14 INFO - "slavebuilddir": "test" 02:29:14 INFO - } 02:29:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 02:29:14 INFO - Running post-action listener: _resource_record_post_action 02:29:14 INFO - ##### 02:29:14 INFO - ##### Running download-and-extract step. 02:29:14 INFO - ##### 02:29:14 INFO - Running pre-action listener: _resource_record_pre_action 02:29:14 INFO - Running main action method: download_and_extract 02:29:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:14 INFO - https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:29:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/test_packages.json 02:29:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/test_packages.json 02:29:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 02:29:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 02:29:20 INFO - Downloaded 1448 bytes. 02:29:20 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 02:29:20 INFO - Using the following test package requirements: 02:29:20 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 02:29:20 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:29:20 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:29:20 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:20 INFO - u'jsshell-linux-x86_64.zip'], 02:29:20 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:29:20 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 02:29:20 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:29:20 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:29:20 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:29:20 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 02:29:20 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:20 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:29:20 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:29:20 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')]} 02:29:20 INFO - https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:29:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:29:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:29:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:29:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:29:22 INFO - Downloaded 23079152 bytes. 02:29:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:29:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 02:29:24 INFO - Return code: 0 02:29:24 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:24 INFO - https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:29:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:29:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:29:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 02:29:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:29:47 INFO - Downloaded 23079152 bytes. 02:29:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:29:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 02:29:48 INFO - Return code: 0 02:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:48 INFO - https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:29:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 02:29:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 02:29:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 02:29:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:29:50 INFO - Downloaded 10706572 bytes. 02:29:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 02:29:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 02:29:50 INFO - Return code: 0 02:29: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')]} 02:29:50 INFO - https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:29:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:29:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:29:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:29:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:29:52 INFO - Downloaded 59958857 bytes. 02:29:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:29:52 INFO - mkdir: /builds/slave/test-pgo/properties 02:29:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:29:52 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:29:52 INFO - Contents: 02:29:52 INFO - build_url:https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 02:29:53 INFO - Running post-action listener: _resource_record_post_action 02:29:53 INFO - Running post-action listener: set_extra_try_arguments 02:29:53 INFO - ##### 02:29:53 INFO - ##### Running populate-webroot step. 02:29:53 INFO - ##### 02:29:53 INFO - Running pre-action listener: _resource_record_pre_action 02:29:53 INFO - Running main action method: populate_webroot 02:29:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:29:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:29:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:29:53 INFO - '--tppagecycles', 02:29:53 INFO - '7'], 02:29:53 INFO - 'tests': ['tsvgm']}}, 02:29:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:29:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:29:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:29:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:29:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:29:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:29:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:29:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:53 INFO - 'talos_options': ['--e10s'], 02:29:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:29:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:53 INFO - 'tests': ['damp', 'tps']}, 02:29:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:53 INFO - 'talos_options': ['--e10s'], 02:29:53 INFO - 'tests': ['damp', 'tps']}, 02:29:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:29:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:29:53 INFO - 'other': {'tests': ['a11yr', 02:29:53 INFO - 'ts_paint', 02:29:53 INFO - 'tpaint', 02:29:53 INFO - 'sessionrestore', 02:29:53 INFO - 'sessionrestore_no_auto_restore']}, 02:29:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:29:53 INFO - 'tests': ['a11yr', 02:29:53 INFO - 'ts_paint', 02:29:53 INFO - 'tpaint', 02:29:53 INFO - 'sessionrestore', 02:29:53 INFO - 'sessionrestore_no_auto_restore']}, 02:29:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:29:53 INFO - 'tests': ['a11yr', 02:29:53 INFO - 'ts_paint', 02:29:53 INFO - 'tpaint', 02:29:53 INFO - 'sessionrestore', 02:29:53 INFO - 'sessionrestore_no_auto_restore']}, 02:29:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:29:53 INFO - 'tests': ['a11yr', 02:29:53 INFO - 'ts_paint', 02:29:53 INFO - 'tpaint', 02:29:53 INFO - 'sessionrestore', 02:29:53 INFO - 'sessionrestore_no_auto_restore']}, 02:29:53 INFO - 'other_l64': {'tests': ['a11yr', 02:29:53 INFO - 'ts_paint', 02:29:53 INFO - 'tpaint', 02:29:53 INFO - 'sessionrestore', 02:29:53 INFO - 'sessionrestore_no_auto_restore']}, 02:29:53 INFO - 'other_nol64': {'tests': ['a11yr', 02:29:53 INFO - 'ts_paint', 02:29:53 INFO - 'tpaint', 02:29:53 INFO - 'sessionrestore', 02:29:53 INFO - 'sessionrestore_no_auto_restore']}, 02:29:53 INFO - 'svgr': {'tests': ['tsvgx', 02:29:53 INFO - 'tsvgr_opacity', 02:29:53 INFO - 'tart', 02:29:53 INFO - 'tscrollx', 02:29:53 INFO - 'cart']}, 02:29:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:29:53 INFO - 'tests': ['tsvgx', 02:29:53 INFO - 'tsvgr_opacity', 02:29:53 INFO - 'tart', 02:29:53 INFO - 'tscrollx', 02:29:53 INFO - 'cart']}, 02:29:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:53 INFO - 'tests': ['tp5o']}, 02:29:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:53 INFO - 'talos_options': ['--e10s'], 02:29:53 INFO - 'tests': ['tp5o']}, 02:29:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:53 INFO - 'talos_options': ['--xperf_path', 02:29:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:29:53 INFO - 'tests': ['tp5n']}, 02:29:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:53 INFO - 'talos_options': ['--e10s', 02:29:53 INFO - '--xperf_path', 02:29:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:29:53 INFO - 'tests': ['tp5n']}}, 02:29:53 INFO - 'talos.zip': {'path': '', 02:29:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:29:53 INFO - Running post-action listener: _resource_record_post_action 02:29:53 INFO - ##### 02:29:53 INFO - ##### Running create-virtualenv step. 02:29:53 INFO - ##### 02:29:53 INFO - Running pre-action listener: _resource_record_pre_action 02:29:53 INFO - Running main action method: create_virtualenv 02:29:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:29:53 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 02:29:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:29:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:29:53 INFO - Using real prefix '/usr' 02:29:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:30:04 INFO - Installing distribute.............................................................................................................................................................................................done. 02:30:06 INFO - Installing pip.................done. 02:30:06 INFO - Return code: 0 02:30:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:06 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 0x7fceb29a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90660>, '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 0xe91560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91a10>, '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': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', '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 02:30:06 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 02:30:06 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 02:30:06 INFO - Using env: {'DISPLAY': ':0', 02:30:06 INFO - 'HOME': '/home/cltbld', 02:30:06 INFO - 'LANG': 'en_US.UTF-8', 02:30:06 INFO - 'LANGUAGE': 'en_US:en', 02:30:06 INFO - 'LOGNAME': 'cltbld', 02:30:06 INFO - 'MAIL': '/var/mail/cltbld', 02:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:06 INFO - 'MOZ_NO_REMOTE': '1', 02:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:06 INFO - 'NO_EM_RESTART': '1', 02:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:06 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:06 INFO - 'SHELL': '/bin/bash', 02:30:06 INFO - 'SHLVL': '1', 02:30:06 INFO - 'TERM': 'linux', 02:30:06 INFO - 'TMOUT': '86400', 02:30:06 INFO - 'USER': 'cltbld', 02:30:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', 02:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:06 INFO - '_': '/tools/buildbot/bin/python'} 02:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:30:06 INFO - Cleaning up... 02:30:06 INFO - Return code: 0 02:30:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:06 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 0x7fceb29a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90660>, '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 0xe91560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91a10>, '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': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', '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 02:30:06 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 02:30:06 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 02:30:06 INFO - Using env: {'DISPLAY': ':0', 02:30:06 INFO - 'HOME': '/home/cltbld', 02:30:06 INFO - 'LANG': 'en_US.UTF-8', 02:30:06 INFO - 'LANGUAGE': 'en_US:en', 02:30:06 INFO - 'LOGNAME': 'cltbld', 02:30:06 INFO - 'MAIL': '/var/mail/cltbld', 02:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:06 INFO - 'MOZ_NO_REMOTE': '1', 02:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:06 INFO - 'NO_EM_RESTART': '1', 02:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:06 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:06 INFO - 'SHELL': '/bin/bash', 02:30:06 INFO - 'SHLVL': '1', 02:30:06 INFO - 'TERM': 'linux', 02:30:06 INFO - 'TMOUT': '86400', 02:30:06 INFO - 'USER': 'cltbld', 02:30:06 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', 02:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:06 INFO - '_': '/tools/buildbot/bin/python'} 02:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:06 INFO - Downloading/unpacking psutil>=0.7.1 02:30: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 02:30: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 02:30: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 02:30: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 02:30: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 02:30: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 02:30:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:30:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:30:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:30:08 INFO - Installing collected packages: psutil 02:30:08 INFO - Running setup.py install for psutil 02:30:08 INFO - building 'psutil._psutil_linux' extension 02:30:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:30:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:30:10 INFO - building 'psutil._psutil_posix' extension 02:30:10 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 02:30:10 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 02:30:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:30:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:30:10 INFO - Successfully installed psutil 02:30:10 INFO - Cleaning up... 02:30:10 INFO - Return code: 0 02:30:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:30:10 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')]} 02:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:10 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')]} 02:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:10 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 0x7fceb29a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90660>, '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 0xe91560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91a10>, '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': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', '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 02:30:10 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 02:30:10 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 02:30:10 INFO - Using env: {'DISPLAY': ':0', 02:30:10 INFO - 'HOME': '/home/cltbld', 02:30:10 INFO - 'LANG': 'en_US.UTF-8', 02:30:10 INFO - 'LANGUAGE': 'en_US:en', 02:30:10 INFO - 'LOGNAME': 'cltbld', 02:30:10 INFO - 'MAIL': '/var/mail/cltbld', 02:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:10 INFO - 'MOZ_NO_REMOTE': '1', 02:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:10 INFO - 'NO_EM_RESTART': '1', 02:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:10 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:10 INFO - 'SHELL': '/bin/bash', 02:30:10 INFO - 'SHLVL': '1', 02:30:10 INFO - 'TERM': 'linux', 02:30:10 INFO - 'TMOUT': '86400', 02:30:10 INFO - 'USER': 'cltbld', 02:30:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', 02:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:10 INFO - '_': '/tools/buildbot/bin/python'} 02:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:12 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:30:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:30:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:30:12 INFO - Installing collected packages: mozsystemmonitor 02:30:12 INFO - Running setup.py install for mozsystemmonitor 02:30:12 INFO - Successfully installed mozsystemmonitor 02:30:12 INFO - Cleaning up... 02:30:12 INFO - Return code: 0 02:30:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fceb29a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90660>, '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 0xe91560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91a10>, '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': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', '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 02:30:12 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 02:30:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:30:12 INFO - Using env: {'DISPLAY': ':0', 02:30:12 INFO - 'HOME': '/home/cltbld', 02:30:12 INFO - 'LANG': 'en_US.UTF-8', 02:30:12 INFO - 'LANGUAGE': 'en_US:en', 02:30:12 INFO - 'LOGNAME': 'cltbld', 02:30:12 INFO - 'MAIL': '/var/mail/cltbld', 02:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:12 INFO - 'MOZ_NO_REMOTE': '1', 02:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:12 INFO - 'NO_EM_RESTART': '1', 02:30:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:12 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:12 INFO - 'SHELL': '/bin/bash', 02:30:12 INFO - 'SHLVL': '1', 02:30:12 INFO - 'TERM': 'linux', 02:30:12 INFO - 'TMOUT': '86400', 02:30:12 INFO - 'USER': 'cltbld', 02:30:12 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', 02:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:12 INFO - '_': '/tools/buildbot/bin/python'} 02:30:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:12 INFO - Downloading/unpacking blobuploader==1.2.4 02:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:14 INFO - Downloading blobuploader-1.2.4.tar.gz 02:30:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:30:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:30:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:15 INFO - Downloading docopt-0.6.1.tar.gz 02:30:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:30:15 INFO - Installing collected packages: blobuploader, requests, docopt 02:30:15 INFO - Running setup.py install for blobuploader 02:30:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:30:15 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:30:15 INFO - Running setup.py install for requests 02:30:15 INFO - Running setup.py install for docopt 02:30:15 INFO - Successfully installed blobuploader requests docopt 02:30:15 INFO - Cleaning up... 02:30:16 INFO - Return code: 0 02:30:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:30:16 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')]} 02:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:16 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')]} 02:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:16 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 0x7fceb29a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90660>, '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 0xe91560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91a10>, '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': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', '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 02:30:16 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 02:30:16 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 02:30:16 INFO - Using env: {'DISPLAY': ':0', 02:30:16 INFO - 'HOME': '/home/cltbld', 02:30:16 INFO - 'LANG': 'en_US.UTF-8', 02:30:16 INFO - 'LANGUAGE': 'en_US:en', 02:30:16 INFO - 'LOGNAME': 'cltbld', 02:30:16 INFO - 'MAIL': '/var/mail/cltbld', 02:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:16 INFO - 'MOZ_NO_REMOTE': '1', 02:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:16 INFO - 'NO_EM_RESTART': '1', 02:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:16 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:16 INFO - 'SHELL': '/bin/bash', 02:30:16 INFO - 'SHLVL': '1', 02:30:16 INFO - 'TERM': 'linux', 02:30:16 INFO - 'TMOUT': '86400', 02:30:16 INFO - 'USER': 'cltbld', 02:30:16 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', 02:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:16 INFO - '_': '/tools/buildbot/bin/python'} 02:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:30:16 INFO - Running setup.py (path:/tmp/pip-WjKwUO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:30:16 INFO - Running setup.py (path:/tmp/pip-4TCHj4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:30:16 INFO - Running setup.py (path:/tmp/pip-lig_GR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:30:16 INFO - Running setup.py (path:/tmp/pip-eQ59Qw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:30:16 INFO - Running setup.py (path:/tmp/pip-gY6cn0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:30:16 INFO - Running setup.py (path:/tmp/pip-oE4NLo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:30:16 INFO - Running setup.py (path:/tmp/pip-7WldUh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:30:16 INFO - Running setup.py (path:/tmp/pip-v3TMK0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:30:16 INFO - Running setup.py (path:/tmp/pip-TwwG6Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:30:16 INFO - Running setup.py (path:/tmp/pip-vtCOeO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:30:16 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:30:16 INFO - Running setup.py (path:/tmp/pip-NZVYXy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:30:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:30:17 INFO - Running setup.py (path:/tmp/pip-Y7j9Os-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:30:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:30:17 INFO - Running setup.py (path:/tmp/pip-W_1Ce2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:30:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:30:17 INFO - Running setup.py (path:/tmp/pip-T4k3xb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:30:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:30:17 INFO - Running setup.py (path:/tmp/pip-quZ_ji-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:30:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:30:17 INFO - Running setup.py (path:/tmp/pip-SWYbx9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:30:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:30:17 INFO - Running setup.py (path:/tmp/pip-ysXyMQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:30:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:30:17 INFO - Running setup.py install for manifestparser 02:30:17 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:30:17 INFO - Running setup.py install for mozcrash 02:30:17 INFO - Running setup.py install for mozdebug 02:30:17 INFO - Running setup.py install for mozdevice 02:30:17 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:30:17 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:30:17 INFO - Running setup.py install for mozfile 02:30:17 INFO - Running setup.py install for mozhttpd 02:30:18 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:30:18 INFO - Running setup.py install for mozinfo 02:30:18 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:30:18 INFO - Running setup.py install for mozInstall 02:30:18 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:30:18 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:30:18 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:30:18 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:30:18 INFO - Running setup.py install for mozleak 02:30:18 INFO - Running setup.py install for mozlog 02:30:18 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:30:18 INFO - Running setup.py install for moznetwork 02:30:18 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:30:18 INFO - Running setup.py install for mozprocess 02:30:18 INFO - Running setup.py install for mozprofile 02:30:18 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:30:18 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:30:18 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:30:18 INFO - Running setup.py install for mozrunner 02:30:18 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:30:18 INFO - Running setup.py install for mozscreenshot 02:30:19 INFO - Running setup.py install for moztest 02:30:19 INFO - Running setup.py install for mozversion 02:30:19 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:30:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:30:19 INFO - Cleaning up... 02:30:19 INFO - Return code: 0 02:30:19 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:30: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')]} 02:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30: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')]} 02:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:19 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 0x7fceb29a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90660>, '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 0xe91560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91a10>, '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': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', '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 02:30:19 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 02:30:19 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 02:30:19 INFO - Using env: {'DISPLAY': ':0', 02:30:19 INFO - 'HOME': '/home/cltbld', 02:30:19 INFO - 'LANG': 'en_US.UTF-8', 02:30:19 INFO - 'LANGUAGE': 'en_US:en', 02:30:19 INFO - 'LOGNAME': 'cltbld', 02:30:19 INFO - 'MAIL': '/var/mail/cltbld', 02:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:19 INFO - 'MOZ_NO_REMOTE': '1', 02:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:19 INFO - 'NO_EM_RESTART': '1', 02:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:19 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:19 INFO - 'SHELL': '/bin/bash', 02:30:19 INFO - 'SHLVL': '1', 02:30:19 INFO - 'TERM': 'linux', 02:30:19 INFO - 'TMOUT': '86400', 02:30:19 INFO - 'USER': 'cltbld', 02:30:19 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', 02:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:19 INFO - '_': '/tools/buildbot/bin/python'} 02:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:30:19 INFO - Running setup.py (path:/tmp/pip-RgtKQg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:30:19 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)) 02:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:30:19 INFO - Running setup.py (path:/tmp/pip-Fjzkii-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:30:19 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)) 02:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:30:19 INFO - Running setup.py (path:/tmp/pip-vs6auW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:30:19 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)) 02:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:30:19 INFO - Running setup.py (path:/tmp/pip-KvUa2Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:30:19 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)) 02:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:30:19 INFO - Running setup.py (path:/tmp/pip-UX5n5M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:30:19 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)) 02:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:30:19 INFO - Running setup.py (path:/tmp/pip-M6rCOO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:30:19 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)) 02:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:30:19 INFO - Running setup.py (path:/tmp/pip-7qPZWe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:30:19 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)) 02:30:19 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:30:19 INFO - Running setup.py (path:/tmp/pip-58wB5S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:30:20 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)) 02:30:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:30:20 INFO - Running setup.py (path:/tmp/pip-SWoFPJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:30:20 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)) 02:30:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:30:20 INFO - Running setup.py (path:/tmp/pip-fzOoma-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:30:20 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)) 02:30:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:30:20 INFO - Running setup.py (path:/tmp/pip-uRQa9e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:30:20 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)) 02:30:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:30:20 INFO - Running setup.py (path:/tmp/pip-HeO9Di-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:30:20 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)) 02:30:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:30:20 INFO - Running setup.py (path:/tmp/pip-enEFM_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:30:20 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)) 02:30:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:30:20 INFO - Running setup.py (path:/tmp/pip-ZmX56A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:30:20 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)) 02:30:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:30:20 INFO - Running setup.py (path:/tmp/pip-ryYfuV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:30:20 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)) 02:30:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:30:20 INFO - Running setup.py (path:/tmp/pip-yLFfLE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:30:20 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)) 02:30:20 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:30:20 INFO - Running setup.py (path:/tmp/pip-hYXNKp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:30:20 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)) 02:30:20 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)) 02:30:20 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)) 02:30:20 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)) 02:30:20 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)) 02:30:20 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)) 02:30:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:30:20 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 02:30:20 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 02:30:20 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 02:30:20 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 02:30:20 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 02:30:20 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 02:30:22 INFO - Downloading blessings-1.6.tar.gz 02:30:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:30:22 INFO - Installing collected packages: blessings 02:30:22 INFO - Running setup.py install for blessings 02:30:22 INFO - Successfully installed blessings 02:30:22 INFO - Cleaning up... 02:30:22 INFO - Return code: 0 02:30:22 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:30:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:30:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:30:22 INFO - Reading from file tmpfile_stdout 02:30:22 INFO - Current package versions: 02:30:22 INFO - argparse == 1.2.1 02:30:22 INFO - blessings == 1.6 02:30:22 INFO - blobuploader == 1.2.4 02:30:22 INFO - docopt == 0.6.1 02:30:22 INFO - manifestparser == 1.1 02:30:22 INFO - mozInstall == 1.12 02:30:22 INFO - mozcrash == 0.16 02:30:22 INFO - mozdebug == 0.1 02:30:22 INFO - mozdevice == 0.48 02:30:22 INFO - mozfile == 1.2 02:30:22 INFO - mozhttpd == 0.7 02:30:22 INFO - mozinfo == 0.9 02:30:22 INFO - mozleak == 0.1 02:30:22 INFO - mozlog == 3.1 02:30:22 INFO - moznetwork == 0.27 02:30:22 INFO - mozprocess == 0.22 02:30:22 INFO - mozprofile == 0.28 02:30:22 INFO - mozrunner == 6.11 02:30:22 INFO - mozscreenshot == 0.1 02:30:22 INFO - mozsystemmonitor == 0.0 02:30:22 INFO - moztest == 0.7 02:30:22 INFO - mozversion == 1.4 02:30:22 INFO - psutil == 3.1.1 02:30:22 INFO - requests == 1.2.3 02:30:22 INFO - wsgiref == 0.1.2 02:30:22 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:30:22 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')]} 02:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:22 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')]} 02:30:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:22 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 0x7fceb29a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90660>, '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 0xe91560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91a10>, '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': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', '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 02:30:22 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 02:30:22 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 02:30:22 INFO - Using env: {'DISPLAY': ':0', 02:30:22 INFO - 'HOME': '/home/cltbld', 02:30:22 INFO - 'LANG': 'en_US.UTF-8', 02:30:22 INFO - 'LANGUAGE': 'en_US:en', 02:30:22 INFO - 'LOGNAME': 'cltbld', 02:30:22 INFO - 'MAIL': '/var/mail/cltbld', 02:30:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:22 INFO - 'MOZ_NO_REMOTE': '1', 02:30:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:22 INFO - 'NO_EM_RESTART': '1', 02:30:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:22 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:22 INFO - 'SHELL': '/bin/bash', 02:30:22 INFO - 'SHLVL': '1', 02:30:22 INFO - 'TERM': 'linux', 02:30:22 INFO - 'TMOUT': '86400', 02:30:22 INFO - 'USER': 'cltbld', 02:30:22 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', 02:30:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:22 INFO - '_': '/tools/buildbot/bin/python'} 02:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:23 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)) 02:30:23 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)) 02:30:23 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)) 02:30:23 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)) 02:30:23 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)) 02:30:23 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)) 02:30:23 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)) 02:30:23 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)) 02:30:23 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)) 02:30:23 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)) 02:30:23 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)) 02:30:23 INFO - Cleaning up... 02:30:23 INFO - Return code: 0 02:30:23 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:30:23 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')]} 02:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:23 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')]} 02:30:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:23 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 0x7fceb29a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90660>, '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 0xe91560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91a10>, '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': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', '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 02:30:23 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 02:30:23 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 02:30:23 INFO - Using env: {'DISPLAY': ':0', 02:30:23 INFO - 'HOME': '/home/cltbld', 02:30:23 INFO - 'LANG': 'en_US.UTF-8', 02:30:23 INFO - 'LANGUAGE': 'en_US:en', 02:30:23 INFO - 'LOGNAME': 'cltbld', 02:30:23 INFO - 'MAIL': '/var/mail/cltbld', 02:30:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:23 INFO - 'MOZ_NO_REMOTE': '1', 02:30:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:23 INFO - 'NO_EM_RESTART': '1', 02:30:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:23 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:23 INFO - 'SHELL': '/bin/bash', 02:30:23 INFO - 'SHLVL': '1', 02:30:23 INFO - 'TERM': 'linux', 02:30:23 INFO - 'TMOUT': '86400', 02:30:23 INFO - 'USER': 'cltbld', 02:30:23 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', 02:30:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:23 INFO - '_': '/tools/buildbot/bin/python'} 02:30:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:23 INFO - Downloading/unpacking jsonschema 02:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:30:25 INFO - Downloading/unpacking functools32 (from jsonschema) 02:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:25 INFO - Downloading functools32-3.2.3-2.tar.gz 02:30:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:30:25 INFO - warning: no files found matching '*.txt' 02:30:25 INFO - no previously-included directories found matching 'build' 02:30:25 INFO - no previously-included directories found matching 'dist' 02:30:25 INFO - no previously-included directories found matching '.git*' 02:30:25 INFO - Installing collected packages: jsonschema, functools32 02:30:25 INFO - Running setup.py install for functools32 02:30:25 INFO - warning: no files found matching '*.txt' 02:30:25 INFO - no previously-included directories found matching 'build' 02:30:25 INFO - no previously-included directories found matching 'dist' 02:30:25 INFO - no previously-included directories found matching '.git*' 02:30:25 INFO - Successfully installed jsonschema functools32 02:30:25 INFO - Cleaning up... 02:30:25 INFO - Return code: 0 02:30:25 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:30:25 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')]} 02:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:30:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:25 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')]} 02:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:30:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:30:25 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 0x7fceb29a5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe01480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe90660>, '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 0xe91560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91a10>, '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': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', '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 02:30:25 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 02:30:25 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 02:30:25 INFO - Using env: {'DISPLAY': ':0', 02:30:25 INFO - 'HOME': '/home/cltbld', 02:30:25 INFO - 'LANG': 'en_US.UTF-8', 02:30:25 INFO - 'LANGUAGE': 'en_US:en', 02:30:25 INFO - 'LOGNAME': 'cltbld', 02:30:25 INFO - 'MAIL': '/var/mail/cltbld', 02:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:25 INFO - 'MOZ_NO_REMOTE': '1', 02:30:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:25 INFO - 'NO_EM_RESTART': '1', 02:30:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:25 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:25 INFO - 'SHELL': '/bin/bash', 02:30:25 INFO - 'SHLVL': '1', 02:30:25 INFO - 'TERM': 'linux', 02:30:25 INFO - 'TMOUT': '86400', 02:30:25 INFO - 'USER': 'cltbld', 02:30:25 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', 02:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:25 INFO - '_': '/tools/buildbot/bin/python'} 02:30:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:30:25 INFO - Downloading/unpacking flake8 02:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:30:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:30:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:30:27 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:30:27 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 02:30:27 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 02:30:27 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 02:30:27 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 02:30:27 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 02:30:27 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 02:30:27 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:30:27 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:30:27 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 02:30:27 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 02:30:27 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 02:30:27 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 02:30:27 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 02:30:27 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 02:30:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:30:28 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 02:30:28 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 02:30:28 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 02:30:28 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 02:30:28 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 02:30:28 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 02:30:28 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:30:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:30:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:30:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:30:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:30:28 INFO - no previously-included directories found matching 'docs/_build' 02:30:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:30:28 INFO - Running setup.py install for pep8 02:30:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:30:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:30:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:30:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:30:28 INFO - no previously-included directories found matching 'docs/_build' 02:30:28 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:30:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:30:28 INFO - Cleaning up... 02:30:28 INFO - Return code: 0 02:30:28 INFO - Running post-action listener: _resource_record_post_action 02:30:28 INFO - Running post-action listener: _start_resource_monitoring 02:30:28 INFO - Starting resource monitoring. 02:30:28 INFO - ##### 02:30:28 INFO - ##### Running install step. 02:30:28 INFO - ##### 02:30:28 INFO - Running pre-action listener: _resource_record_pre_action 02:30:28 INFO - Running main action method: install 02:30:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:30:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:30:28 INFO - Reading from file tmpfile_stdout 02:30:28 INFO - Detecting whether we're running mozinstall >=1.0... 02:30:28 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:30:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:30:29 INFO - Reading from file tmpfile_stdout 02:30:29 INFO - Output received: 02:30:29 INFO - Usage: mozinstall [options] installer 02:30:29 INFO - Options: 02:30:29 INFO - -h, --help show this help message and exit 02:30:29 INFO - -d DEST, --destination=DEST 02:30:29 INFO - Directory to install application into. [default: 02:30:29 INFO - "/builds/slave/test-pgo"] 02:30:29 INFO - --app=APP Application being installed. [default: firefox] 02:30:29 INFO - mkdir: /builds/slave/test-pgo/build/application 02:30:29 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 02:30:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 02:30:44 INFO - Reading from file tmpfile_stdout 02:30:44 INFO - Output received: 02:30:44 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:30:44 INFO - Running post-action listener: _resource_record_post_action 02:30:44 INFO - ##### 02:30:44 INFO - ##### Running run-tests step. 02:30:44 INFO - ##### 02:30:44 INFO - Running pre-action listener: _resource_record_pre_action 02:30:44 INFO - Running main action method: run_tests 02:30:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:30:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:30:44 INFO - Python 2.7.3 02:30:44 INFO - Return code: 0 02:30:44 INFO - grabbing minidump binary from tooltool 02:30: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')]} 02:30:44 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 0xe90660>, '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 0xe91560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:30:44 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 02:30:44 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 02:30:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:30:44 INFO - Return code: 0 02:30:44 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:30:44 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:30:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:30:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:30:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:30:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:30:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:30:45 INFO - Return code: 0 02:30:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 02:30:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 02:30:45 INFO - Using env: {'DISPLAY': ':0', 02:30:45 INFO - 'HOME': '/home/cltbld', 02:30:45 INFO - 'LANG': 'en_US.UTF-8', 02:30:45 INFO - 'LANGUAGE': 'en_US:en', 02:30:45 INFO - 'LOGNAME': 'cltbld', 02:30:45 INFO - 'MAIL': '/var/mail/cltbld', 02:30:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:30:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:45 INFO - 'MOZ_NO_REMOTE': '1', 02:30:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:45 INFO - 'NO_EM_RESTART': '1', 02:30:45 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:30:45 INFO - 'PWD': '/builds/slave/test-pgo', 02:30:45 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:30:45 INFO - 'SHELL': '/bin/bash', 02:30:45 INFO - 'SHLVL': '1', 02:30:45 INFO - 'TERM': 'linux', 02:30:45 INFO - 'TMOUT': '86400', 02:30:45 INFO - 'USER': 'cltbld', 02:30:45 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360', 02:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:45 INFO - '_': '/tools/buildbot/bin/python'} 02:30:45 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 02:30:45 INFO - mozversion application_buildid: 20160227030340 02:30:45 INFO - mozversion application_changeset: b5df3e5a52c8f97d97c44f7e200c866796da116f 02:30:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:30:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:30:45 INFO - mozversion application_name: Firefox 02:30:45 INFO - mozversion application_remotingname: firefox-dev 02:30:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:30:45 INFO - mozversion application_vendor: Mozilla 02:30:45 INFO - mozversion application_version: 46.0a2 02:30:45 INFO - mozversion platform_buildid: 20160227030340 02:30:45 INFO - mozversion platform_changeset: b5df3e5a52c8f97d97c44f7e200c866796da116f 02:30:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:30:45 INFO - mozversion platform_version: 46.0a2 02:30:45 INFO - using testdate: 1456655445 02:30:45 INFO - actual date: 1456655445 02:30:45 INFO - starting webserver on 'localhost:44923' 02:30:45 INFO - SUITE-START | Running 3 tests 02:30:45 INFO - TEST-START | dromaeo_css 02:30:45 INFO - operating with platform_type : linux_ 02:30:45 INFO - Initialising browser for dromaeo_css test... 02:30:45 INFO - TEST-INFO | started process 3417 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHbIZqW/profile http://localhost:44923/getInfo.html) 02:30:55 INFO - PROCESS | 3417 | __metrics Screen width/height:1600/1200 02:30:55 INFO - PROCESS | 3417 | colorDepth:24 02:30:55 INFO - PROCESS | 3417 | Browser inner width/height: 1024/697 02:30:55 INFO - PROCESS | 3417 | __metrics 02:30:56 INFO - PROCESS | 3417 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:30:57 INFO - TEST-INFO | 3417: exit 0 02:30:57 INFO - Browser initialized. 02:30:57 INFO - Running cycle 1/1 for dromaeo_css test... 02:30:57 INFO - TEST-INFO | started process 3508 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpHbIZqW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:31:09 INFO - PROCESS | 3508 | RSS: Main: 139182080 02:31:09 INFO - PROCESS | 3508 | 02:32:00 INFO - PROCESS | 3508 | 1456655520122 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] 02:34:08 INFO - PROCESS | 3508 | Cycle 1(1): loaded http://localhost:44923/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44923/tests/dromaeo/cssquery-ext.html) 02:34:09 INFO - PROCESS | 3508 | RSS: Main: 210767872 02:34:09 INFO - PROCESS | 3508 | 02:37:11 INFO - PROCESS | 3508 | Cycle 1(1): loaded http://localhost:44923/tests/dromaeo/cssquery-ext.html (next: http://localhost:44923/tests/dromaeo/cssquery-jquery.html) 02:37:12 INFO - PROCESS | 3508 | RSS: Main: 222466048 02:37:12 INFO - PROCESS | 3508 | 02:40:13 INFO - PROCESS | 3508 | Cycle 1(1): loaded http://localhost:44923/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44923/tests/dromaeo/cssquery-mootools.html) 02:40:14 INFO - PROCESS | 3508 | RSS: Main: 220876800 02:40:14 INFO - PROCESS | 3508 | 02:43:16 INFO - PROCESS | 3508 | Cycle 1(1): loaded http://localhost:44923/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44923/tests/dromaeo/cssquery-prototype.html) 02:43:16 INFO - PROCESS | 3508 | RSS: Main: 202342400 02:43:16 INFO - PROCESS | 3508 | 02:46:19 INFO - PROCESS | 3508 | Cycle 1(1): loaded http://localhost:44923/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44923/tests/dromaeo/cssquery-yui.html) 02:46:19 INFO - PROCESS | 3508 | RSS: Main: 208154624 02:46:19 INFO - PROCESS | 3508 | 02:49:22 INFO - PROCESS | 3508 | Cycle 1(1): loaded http://localhost:44923/tests/dromaeo/cssquery-yui.html (next: http://localhost:44923/tests/dromaeo/cssquery-dojo.html) 02:49:22 INFO - PROCESS | 3508 | RSS: Main: 244080640 02:49:22 INFO - PROCESS | 3508 | 02:49:22 INFO - PROCESS | 3508 | __start_tp_report 02:49:22 INFO - PROCESS | 3508 | _x_x_mozilla_page_load 02:49:22 INFO - PROCESS | 3508 | _x_x_mozilla_page_load_details 02:49:22 INFO - PROCESS | 3508 | |i|pagename|runs| 02:49:22 INFO - PROCESS | 3508 | |0;dojo.html;3156.684331566843;3210.2295449092194;3233.9514907276393;3248;3276.0171948415477;5066.316047333609;5072.365954255718;5101.846944591659;5103.719295438749;5127.051495473335;5076.85770701592;5095.235714642806;5096.082705113078;5123.359580052494;5129.0767661820855;4605.884852878688;4652.069586082788;4670.953290467086;4705.129551033053;4719.90560188796;4659.697119687209;4677.345171675968;4700.858974230779;4702;4707.693999890013;4657.4876763555985;4729.810807567693;4804.543568361;4838.612910967132;4846;4752.976235118819;4785.1386750384745;4806.086843499724;4807.807687692488;4834.540718631724;4703.576678098988;4721.881952951169;4740.217864052427;4749.216379297412;4782.521747825224;4900.313956046157;4914.63140264478;4982.676126051795;4997.350344455234;5058.873528161788;5509.47659972302;5514.503694667499;5515.806946756885;5532.723363831833;5557.416471270499;5491.670499769986;5537.916931246034;5550.639208451437;5553.194786755938;5564.805231816867;5009.724465154415;5118.97440512795;5191.195364718475;5212.55693266069;5218.686878787209;5622.550195984311;5637.126245431965;5637.633553818989;5639.351474580476;5643.689597072118;5415.079436495806;5419.132938729863;5423.918641220384;5424.159255315432;5428.240046393508;5406.297181366397;5440.700761458079;5463.262459567987;5493.587980901449;5593.328800543879;5447.945520544744;5469.699166545878;5474.534664553478;5474.562035037187;5483.506484416342;5381.461853814665;5394.703291319015;5397.595180361489;5423.891522169613;5470.617056806065;4240.448741663564;4256.616904478612;4296.2696341621995;4299.527052024275;4319.265724826724;3859.073822282632;3876.7092468064443;3890.085829830044;3909.354956432157;3910.6089391061237;5114.769835357418;5237.3453318335205;5252.579793616502;5257.842264732064;5274.736263186825;5367.033933891859;5461.808836690697;5509.559235261169;5511.944880551143;5541.362743284493;5169.405518365361;5190.221466779938;5209.348831396075;5209.843704688866;5253.527182553588;4699.271612900006;4725.810967561328;4788.856334309976;4794.089123066607;4804.447488538863;5636.802711905064;5689.658620482702;5711.171880077449;5724.713764311768;5757.65454072757;5469.2616496772425;5504.174373843795;5505.091659876076;5505.889882202414;5518.724063796874;5571.554275657856;5657.858553536194;5670.914936275876;5701.515371193329;5742.741576628978;5443.7278136092245;5448.427915068861;5450;5457.699826509422;5462.098753705594;5508.944910550843;5510.531604813636;5511.972440137773;5522.22688823573;5546.667199968015;5254.816081437131;5339.3058902342445;5350.384705758887;5394.9460505394445;5463;5360.0619891518045;5365.356157261153;5373.247745315737;5375.973120134374;5378.031954248273;5276.023935571931;5279.10255256615;5283.524482796567;5285.127953887565;5306.177542480922;5227.58179345659;5333.493318134771;5360.892782144413;5415.350157981067;5480.671159730429;5310.920336194883;5315.495027972336;5317.069512835315;5326.254324394666;5331.280277162534 02:49:22 INFO - PROCESS | 3508 | |1;ext.html;546.0880329849151;557.0474488624452;564.1227890630071;582.7348556406836;583.6498101139317;30492.847535762317;31282;39849.00377490561;40223.59776402235;40328;42673.57326426735;43040.56959430405;43136.137277254435;43174.78412607933;43210.351844722274;8706.129387061306;8990.64037438505;8994.68518601849;9001.909980900205;9004.729858104267;8623.267022303111;8658.87011694825;8753.474791512497;8757.211850933414;8758;9020.45877247364;9072.27421806254;9083.954580227122;9088.863667044967;9104.726858194264;8952.328575356842;9012.819743605156;9013.819723605524;9016.549172541347;9017.864732029026;8943.50810705411;9110.407823491452;9118.04260552639;9126.041765614647;9126.634934602607;42789.78605106955;43173;43245.78377108126;43250.78374608138;43382.56617433817;3579.713622910187;3842.737876724481;3859.247446747885;4005.8798236052967;4126.463559737245;32519.83740081308;32859.17852053694;33035.834820825985;33044;33062.17344566381;4299.72051816634;4376.168527979674;4380.846670366522;4399.604035636776;4480.059187570614;272957;273209;273760;274069;274314;59681.701591491765;64547.35452645507;64860;64919.67540162364;65023;53440.73279633577;70166.298337017;71263.6436817823;71339.28660713327;71407.6429617859;17768.28926842912;17881.463556093076;18039.368622098427;18291.26834926588;18320.358787442376;13560.118592291667;13745.587632371045;14256.786148207786;14345.354459049368;14419.134851908919;21190.15239390438;21743.34769956904;21769.782302176776;21858.234961776263;21935.341939741833;7954.767011113287;8203.71287004964;8244.670213191404;8333.8333233335;8387.706430274911;1087.075985412393;1164.3537836500655;1195.2947760821157;1237.1834589171103;1275.9234445933273;30416;30661.387680924203;31007.379852403275;31601.36797264042;31795.364092718017;1194.8685644579089;1198.3708553009565;1243.894268987128;1303.7066660001424;1311.010187308576;14619.415223391157;16332.75500867488;16541.58646033859;16677.08276044829;16852.494425167264;388411.11588884314;391724;392252;392291;392547;58373;58742;58746;58773.11840322398;58833.11750323749;1369.8493165751759;1426.9571912842423;1515.2953876447284;1518.9240537973058;1529.2048134969975;27667.308317292227;27939.58090628683;28103.297417564725;31038.68961310358;31531.68468315379;46618.06763864771;47084.05831883412;47109.76445117752;47114;47198.87605057712;317301;318050;332614;338713;339165;33248.501272481415;33501.32997340088;33537.16157096092;33695;33722.156946076546;48009.87935784163;48445;48514.51485485241;49126.75436622794;49674.254886177456;39092.60907391003;40037.19925601414;40253.1949361017;40711.38932916068;41080;38512.80743596264;40258.597414026655;40323.395149073374;40477.39283910685;40834.59165408308;36858.078548036516;37077.6292237085;37771.43342849804;42022.78988605038;42142;34205.48691769576;35062.12344691403;36268.27463450769;36966.445503316936;37217.44173837449;24943.501129977663;25063.49873002566;25217.243482695547;25255.74744252534;25455 02:49:22 INFO - PROCESS | 3508 | |2;jquery.html;394.44974260906037;398.0685196639863;398.6571548468317;400.43738547340996;400.47937681014673;13252.734945301088;17002.65994680107;17503.212355444004;17504.562385940357;18820.71768923464;17286.827131728678;17479.563010924732;17499.65000699985;17499.73750393742;17570.648587028252;5905.586608937366;6082.847928801793;6088.391160883921;6094.725737341808;6127.5404344674325;5819.53443724501;5965.88068238635;6046.697665116749;6049.788257410992;6074.240719910012;4598.126355992367;4734.479207287196;6104.877902441948;6148.446639802417;6559.212894452672;6312.905306420407;6507.837304067412;6638.203415590112;6640.734370625193;6890.586564806077;6608.933910660928;6630.370114839083;6638.93361066388;6655.968324909647;6661.800145995628;22139.225127120633;22433.66349504759;22604.434889127904;22669.546609067726;23152.305430837103;2354.117206047732;2428.295794219674;2452.3623857796924;2474.381404648838;2511.1713134665515;14068.085574437731;14475.015324200347;14496.710065798625;14752.041117327446;15005.849941500554;2053.4558342039372;2095.7275554178013;2115.862468939514;2126.2345555599973;2137.9786202137934;66801;67119.3288067118;67178.9999999995;67924.66037669829;68728.6563567179;14913.105213687213;14915.105093694414;14943.850561494246;14947.103173809388;14968.700625987638;22592.209272675707;22720.772792271866;22792.658110128363;22832.429189270068;22848.65727014096;9098.681546145854;9143.085691430937;9145.771355716028;9170;9262.16640502358;7870.29167374939;7887.447878648554;7915.722949696733;7944.483608565541;7955.204479552114;7032.33192846689;7068.858622827514;7099.89350159748;7110.893336599956;7230.855382892418;2513.773760361576;3027.848607569613;3043.4521786078717;3136.2943337748825;3149.937001259962;965.9420434773936;1000.1448761309122;1052.9578816847393;1070.9518071686794;1193.4152265389896;16625.7506137408;16652.250648720837;16826.663466730595;17045.659086818443;17089.401870934456;1033.4574348467115;1062.9893701063045;1078.223678951154;1092.191778084212;1123.7078359626555;9970.152537034288;10313.48432578368;10411.687649370531;10412.635557755593;10435.37387756737;348407;349592;350916;476008;557380;48682.51317486851;63411;72234.27765722276;76165.61917190379;82388.58805706054;1176.9470373833199;1206.7586482703493;1211.7758214730304;1213.696575856036;1219.378117160237;15394.692106158038;15400.691986160438;15654.45209417665;15712.607184820014;15861.920690396475;33993.490097648064;34252.48621270633;34274.65725342715;35238.823805880806;35601.28797424089;46189.53810461852;46211.76894115508;46385;46653;49469.25796112989;7057.329553692391;7165.641717914188;7262.382697470563;7500.099988001475;7709.537427754352;11357.148213884157;11516.481758320728;11538.711532211762;11694.356810375511;11829.290242585128;9655.068986202647;9743.756406089904;9892.060254275832;10274.589016439259;10287.53706083243;10014.198864091;10227.846582301123;10290.588376464857;10416.166706663296;10630.787384252426;10120.493975301059;10347.94826025865;10449.373037617766;10495.527701253615;10658.73353166177;7368.557886526825;7537.736179233701;7546.358559522502;7567.810804729926;7569.621518924142;7662.616869156632;8157.592120394075;8219.506829590244;8230;9807.117359437685 02:49:22 INFO - PROCESS | 3508 | |3;mootools.html;1458.6426325550242;1532.1496569403982;1545.5595155380718;1569.270289315468;1625.5529729324435;7472.4395670324675;8026.678932842687;8127.471714338579;8156.980377452818;8172.264496195348;7947.403944704156;8077.717279895191;8091.595420228994;8101.5544145072;8112.837743245132;2138.112683236463;2193.846430749848;2405.939851503718;2431.1369463840347;2445.6209287560455;2433.9543075434703;2456.435019945414;2462.9261122166363;2465.704115506142;2466.2971053249826;2422.8667423291713;2441.1578005588044;2450.1179575352858;2452.583060879646;2463.3718401807605;2408.5784987627185;2435.3668046308;2452.982012464825;2456.0298682020593;2456.852588844675;2413.3966508372905;2432.246003738829;2441;2451.8651474168914;2453.570625140611;8435.746927592181;8470.195331443503;8495.74512764618;8500;8507.659693612248;5145.794168233266;5169.793208271664;5218.9739051304505;5267.841964741026;5269.051570717269;3205.214722393005;3224.7097761201603;3395.5585773849243;3413.7781044232047;3421.81180035098;1197;1208.2569219929767;1219.9817002744967;1225.6874497003296;1251.5056552661647;11941.701457463547;11942.582009629708;11957;11960.983316418202;11967.64097077089;4757.738324392122;4773.260144677511;4792.0895029944195;4825.9034819303415;4843.128236917389;10246.026627470379;10247.590096396061;10249.743756406;10256.948715256525;10258.487075646188;5271.683698978073;5287.23335116406;5300.867478313073;5310.468953104659;5311.123664595299;4733.053389322081;4785.210440277316;4813.855584332476;4815.3499277597775;4841.225403935354;3662.853485860536;3718.4050551912105;3944.2900277950243;3962.920741585152;4026.416169655384;1257.2456526084277;1271.2182008064974;1285.5243559882904;1304.373900527752;1313.2842600782596;1365.6312795545346;1375.2367436072875;1380.0753495158267;1397;1402.2427888940063;7804.180561041123;7832.0601527817025;7833.5691536966015;7833.64748586315;7837.843243135106;1185.2177562808677;1186.129566449195;1203.4366798718672;1209.7036226124656;1231.0274882842634;6113.908291375633;6171.537134714914;6178.69106544671;6187.81436556904;6191.690415479298;9975.800483990279;10252.487375631337;10519.579216831242;10629.255952083435;10653.201009924287;10324.277300588887;10492.790144197073;10517;10525.84211236832;10527.420991845522;7861.52830830152;8023.037235531773;8023.4784738991775;8065.314448271963;8101.797455063553;7789.844203115793;7795.571243581658;7833.060032795873;7836.725714599962;7840.176781437867;8918.19736223717;9104.772380690536;9218.769530761785;9416.905830941603;9426.151646351862;9061.95469022677;9176.311776616914;9451.338406311492;9581.760455988377;9583.137517623447;6322.336154703874;7386;7509.136449308399;7520.8871866920945;7521.285477879593;7046.718131274692;7218.458615603956;8041.43709940322;8146.429749917449;8178.754637360888;7617.085949686073;7671.808204794925;7710.498817576839;7716.729914452967;7978.720744773905;7715.344195743424;7781.416393770377;7788.493747906368;7796.415268854745;7857.292843643871;8012.959935200287;8051.074126475531;8052.033755949324;8070.47541909774;8078.353731701567;6923.7576684817805;7101.680424381018;7244;7256.673449694882;7278.890816637649;7103.502754807114;7124.679389427592;7130.500864939404;7145.1425828900865;7154.356107950101 02:49:22 INFO - PROCESS | 3508 | |4;prototype.html;369.9019759763662;381.3536056384428;382.455001622688;383.2258837148958;387.72084099448404;5751.942480575193;5857.56068294878;5873.353931067584;5913.674747888865;5974.701264936757;5645.350784659765;5844.415558444153;5888.41115888411;5915.733791979361;5916.053431450969;4650.883787890907;4656.580907718305;4661.86014419568;4663.27719203524;4665.043666048469;4463.6429085673235;4597.60920321773;4599.678022538407;4601.33280674302;4660.394148760656;4501.324801279801;4591.816327346902;4604;4631.861044168681;4656.324832899228;4605.4933957264675;4625.098105869357;4631.467381251132;4632.559906808848;4642.930356044662;4139.379093136024;4143.647789937859;4144.958550414518;4150.937735933963;4151.356539736345;5533.363663178746;5629.690367029812;5637.577181711347;5638.323401191842;5639.379668236491;5387.595930305243;5389.514943655051;5399.325084364455;5400.054990376669;5401.567874570025;5941.970290148522;6256.405641464054;6263.561550691454;6264.1543391642;6266.49868010558;4431.003024319502;4442.111577684444;4488.236999710057;4509.549045095464;4514;6481.708323125471;6511.837204069936;6522.282548919615;6525.804225873231;6545.443637290884;4683.6721429500285;4694.647901407408;4695.3426520287185;4698.553637404441;4704.223803072523;4498.797554110073;4617.422822147231;4626.653001024936;4761.857144285677;4764.38063051808;5264.105102132647;5269.314989051475;5271;5341.813036543703;5347.705876176769;6322.652254125976;6324.873502529924;6325.272593651697;6331.430171284606;6332.081848131995;1621.391978008247;1648.934042638281;1649.9505014849574;1650.4388507907129;1651.1331550935854;1128.853249077631;1132.1565433751907;1137.70988397958;1139.0318229504855;1153.6193056291404;6150.446459818549;6158.661273629993;6159.076138579159;6160.10678451622;6165.722542485599;6457.935420645734;6468.579542329733;6474.6762661866715;6476.190476190476;6478.578892371981;6017.6389416634265;6115.174451448997;6129.816105516842;6137.96931015351;6151.415615516519;3473.218525831718;3504.9474257886154;3506.3337965786927;3508.7719298245534;3511.5610548681416;6717.227518835396;6732.057511948331;6734.292899245509;6735.696893639798;6735.797926062226;6538.869222615521;6629.436497897636;6653.401193892573;6663;6670.799876003728;6672.899906501407;6691.063251144844;6710.261871194165;6710.563813352116;6718.8320291993095;6217.595856269328;6397.104405383343;6423.42189202974;6439.710213040331;6450.774222902176;6416.390442907917;6432.517561182836;6438.066480360415;6439.259485159267;6451.451626611791;6752.426043786333;6752.93247067523;6756.628385438848;6759.222689390783;6760.22257440381;4519;4592.494825569118;4593.885152871071;4601.010782681739;4612.146752850734;6486.675666216576;6502.414782669583;6505.2844187138435;6506.707198175999;6508.349165083454;6349.301576826638;6358.682065896779;6364;6366.140571022853;6368.044793281045;6204;6331.398517140864;6336.081268216175;6345.809625711236;6350.333215012357;6232.688365581794;6238.781642642486;6245.063240513778;6245.594036387621;6245.7189426476825;6289.213848268966;6305.054241863757;6309.4952403806665;6315.715792789244;6365.267994180728;6006.969965150146;6140.20177376956;6143.232095988002;6231.189945307262;6258.405451482102 02:49:22 INFO - PROCESS | 3508 | |5;yui.html;840.2185967050644;863.689071934104;922.6125027488454;925.8657494663274;938.5635679409074;14001.859981400183;14199.219042952633;14225.92887035566;14243.643908902257;14246.287685615716;13785.655358616039;13846.169229846217;13849.238291893942;13849.930750346233;13857.653558661013;754.543501181784;771.6450432800918;910.1808372464801;919.0855099176296;927.429630777074;913.0549880873298;914.9679761208359;922.1608336413865;924.0528458330198;933.6825479337024;795.5942469340649;955.928305377096;956;956.1872408452829;965.884093908732;801.9839603207932;949.5015117063527;949.9715008549755;955.8757361543024;956;704.4470090978608;709;709.6806437103324;710.5523520182252;710.8613820305043;12731.936340318332;12754.872451275462;12801.359932003363;12816.423260953186;12822.80765788514;13715.314234288246;14017.649558761113;14096;14120;14732.779008314883;11548.422578871106;11645.243059201124;11710.414479276002;11714;11740.64778056651;4002.639762421367;4014.41790940312;4049.2104039712267;4059.817308221137;4065.5731148229306;52403;52445.213321800205;52511.73744131255;53229.2015619766;53417.46582534203;11594.721716734897;11689.649310520697;11784.234024788362;11836.408179590986;11938.28370297785;20611.58776824485;20728.48178795512;20744.89627551883;20797.688034679493;20811.68782468264;8451.23938845507;8501.872471912926;8534.573271336409;8582.699605513777;8610.6986255482;4818.325434439182;4843.321934929113;4862.6839255448285;4862.70823750569;4971.850844474671;3194.6805319467867;3217.4530329843983;3219.5814544109116;3222.8227447490144;3229.0797122819886;577.3187638586425;589.6373730156009;592.2330581896455;599.4574909706722;607.7872744539376;571.3743450921235;619.2661695890384;668.4351722794231;692.3699433515477;706.6502081469705;9295.953520232355;9423.293253006052;9521.714348569554;9672;9847.55685994132;541.2963147907705;640.5228105061666;695.4471195399669;752.8280909575913;755.5089192025227;4325.113351762881;4422.955770442254;4440.533743956903;4473.329000649864;4590.081983603226;61951;63984.68007659932;64186.358136418974;64208;64397;54736;54938.450615494134;56459.153112703345;57416.55500669973;58183;48251.517484824704;49492.50507494951;50161;51836;52185.73907130516;9193.586288616894;9477.24182065447;9684.661036863676;9690.418574885529;9791.363561368487;35643.64356356507;37088.258234835695;37378.43932341071;37700.057498561655;37953.81023094867;48311.5168848307;49054;49131.263031053844;49150.50849491602;50423.24365134599;12088.637340879788;12247.69380765488;12377.814332784836;12405.62783116508;12515.74968500643;13362.265075420944;13408.530701425403;13425.597232083053;13429.597112086652;13630.659233519242;10917.836232456679;11136.888631113585;11453.885461145283;11488.712782180512;12705.809412859;12258.325792081521;12544.372781360713;12675.492980281055;12987.870121298665;13339.266340351374;12685.936570317459;13186.208827470382;13457.327133643474;13538.93230533841;13710.725785484434;9928.156106731009;10146.898531014594;10187.84718229242;10251.38491690501;10724.8927510727;10591.576336946744;10651.840222396826;10765.569377224823;10786.784264314827;10800.24398292112 02:49:22 INFO - PROCESS | 3508 | __end_tp_report 02:49:22 INFO - PROCESS | 3508 | __start_cc_report 02:49:22 INFO - PROCESS | 3508 | _x_x_mozilla_cycle_collect,840 02:49:22 INFO - PROCESS | 3508 | __end_cc_report 02:49:22 INFO - PROCESS | 3508 | __startTimestamp1456656562598__endTimestamp 02:49:22 INFO - PROCESS | 3508 | 02:49:22 INFO - PROCESS | 3508 | ------- Summary: start ------- 02:49:22 INFO - PROCESS | 3508 | Number of tests: 6 02:49:22 INFO - PROCESS | 3508 | 02:49:22 INFO - PROCESS | 3508 | [#0] dojo.html Cycles:165 Average:5124.15 Median:5310.92 stddev:531.28 (10.0%) stddev-sans-first:510.00 02:49:22 INFO - PROCESS | 3508 | Values: 3156.7 3210.2 3234.0 3248.0 3276.0 5066.3 5072.4 5101.8 5103.7 5127.1 5076.9 5095.2 5096.1 5123.4 5129.1 4605.9 4652.1 4671.0 4705.1 4719.9 4659.7 4677.3 4700.9 4702.0 4707.7 4657.5 4729.8 4804.5 4838.6 4846.0 4753.0 4785.1 4806.1 4807.8 4834.5 4703.6 4721.9 4740.2 4749.2 4782.5 4900.3 4914.6 4982.7 4997.4 5058.9 5509.5 5514.5 5515.8 5532.7 5557.4 5491.7 5537.9 5550.6 5553.2 5564.8 5009.7 5119.0 5191.2 5212.6 5218.7 5622.6 5637.1 5637.6 5639.4 5643.7 5415.1 5419.1 5423.9 5424.2 5428.2 5406.3 5440.7 5463.3 5493.6 5593.3 5447.9 5469.7 5474.5 5474.6 5483.5 5381.5 5394.7 5397.6 5423.9 5470.6 4240.4 4256.6 4296.3 4299.5 4319.3 3859.1 3876.7 3890.1 3909.4 3910.6 5114.8 5237.3 5252.6 5257.8 5274.7 5367.0 5461.8 5509.6 5511.9 5541.4 5169.4 5190.2 5209.3 5209.8 5253.5 4699.3 4725.8 4788.9 4794.1 4804.4 5636.8 5689.7 5711.2 5724.7 5757.7 5469.3 5504.2 5505.1 5505.9 5518.7 5571.6 5657.9 5670.9 5701.5 5742.7 5443.7 5448.4 5450.0 5457.7 5462.1 5508.9 5510.5 5512.0 5522.2 5546.7 5254.8 5339.3 5350.4 5394.9 5463.0 5360.1 5365.4 5373.2 5376.0 5378.0 5276.0 5279.1 5283.5 5285.1 5306.2 5227.6 5333.5 5360.9 5415.4 5480.7 5310.9 5315.5 5317.1 5326.3 5331.3 02:49:22 INFO - PROCESS | 3508 | 02:49:22 INFO - PROCESS | 3508 | [#1] ext.html Cycles:180 Average:51276.79 Median:39943.10 stddev:87834.26 (219.9%) stddev-sans-first:87998.07 02:49:22 INFO - PROCESS | 3508 | Values: 546.1 557.0 564.1 582.7 583.6 30492.8 31282.0 39849.0 40223.6 40328.0 42673.6 43040.6 43136.1 43174.8 43210.4 8706.1 8990.6 8994.7 9001.9 9004.7 8623.3 8658.9 8753.5 8757.2 8758.0 9020.5 9072.3 9084.0 9088.9 9104.7 8952.3 9012.8 9013.8 9016.5 9017.9 8943.5 9110.4 9118.0 9126.0 9126.6 42789.8 43173.0 43245.8 43250.8 43382.6 3579.7 3842.7 3859.2 4005.9 4126.5 32519.8 32859.2 33035.8 33044.0 33062.2 4299.7 4376.2 4380.8 4399.6 4480.1 272957.0 273209.0 273760.0 274069.0 274314.0 59681.7 64547.4 64860.0 64919.7 65023.0 53440.7 70166.3 71263.6 71339.3 71407.6 17768.3 17881.5 18039.4 18291.3 18320.4 13560.1 13745.6 14256.8 14345.4 14419.1 21190.2 21743.3 21769.8 21858.2 21935.3 7954.8 8203.7 8244.7 8333.8 8387.7 1087.1 1164.4 1195.3 1237.2 1275.9 30416.0 30661.4 31007.4 31601.4 31795.4 1194.9 1198.4 1243.9 1303.7 1311.0 14619.4 16332.8 16541.6 16677.1 16852.5 388411.1 391724.0 392252.0 392291.0 392547.0 58373.0 58742.0 58746.0 58773.1 58833.1 1369.8 1427.0 1515.3 1518.9 1529.2 27667.3 27939.6 28103.3 31038.7 31531.7 46618.1 47084.1 47109.8 47114.0 47198.9 317301.0 318050.0 332614.0 338713.0 339165.0 33248.5 33501.3 33537.2 33695.0 33722.2 48009.9 48445.0 48514.5 49126.8 49674.3 39092.6 40037.2 40253.2 40711.4 41080.0 38512.8 40258.6 40323.4 40477.4 40834.6 36858.1 37077.6 37771.4 42022.8 42142.0 34205.5 35062.1 36268.3 36966.4 37217.4 24943.5 25063.5 25217.2 25255.7 25455.0 02:49:22 INFO - PROCESS | 3508 | 02:49:22 INFO - PROCESS | 3508 | [#2] jquery.html Cycles:180 Average:25501.93 Median:34122.99 stddev:69703.02 (204.3%) stddev-sans-first:69873.06 02:49:22 INFO - PROCESS | 3508 | Values: 394.4 398.1 398.7 400.4 400.5 13252.7 17002.7 17503.2 17504.6 18820.7 17286.8 17479.6 17499.7 17499.7 17570.6 5905.6 6082.8 6088.4 6094.7 6127.5 5819.5 5965.9 6046.7 6049.8 6074.2 4598.1 4734.5 6104.9 6148.4 6559.2 6312.9 6507.8 6638.2 6640.7 6890.6 6608.9 6630.4 6638.9 6656.0 6661.8 22139.2 22433.7 22604.4 22669.5 23152.3 2354.1 2428.3 2452.4 2474.4 2511.2 14068.1 14475.0 14496.7 14752.0 15005.8 2053.5 2095.7 2115.9 2126.2 2138.0 66801.0 67119.3 67179.0 67924.7 68728.7 14913.1 14915.1 14943.9 14947.1 14968.7 22592.2 22720.8 22792.7 22832.4 22848.7 9098.7 9143.1 9145.8 9170.0 9262.2 7870.3 7887.4 7915.7 7944.5 7955.2 7032.3 7068.9 7099.9 7110.9 7230.9 2513.8 3027.8 3043.5 3136.3 3149.9 965.9 1000.1 1053.0 1071.0 1193.4 16625.8 16652.3 16826.7 17045.7 17089.4 1033.5 1063.0 1078.2 1092.2 1123.7 9970.2 10313.5 10411.7 10412.6 10435.4 348407.0 349592.0 350916.0 476008.0 557380.0 48682.5 63411.0 72234.3 76165.6 82388.6 1176.9 1206.8 1211.8 1213.7 1219.4 15394.7 15400.7 15654.5 15712.6 15861.9 33993.5 34252.5 34274.7 35238.8 35601.3 46189.5 46211.8 46385.0 46653.0 49469.3 7057.3 7165.6 7262.4 7500.1 7709.5 11357.1 11516.5 11538.7 11694.4 11829.3 9655.1 9743.8 9892.1 10274.6 10287.5 10014.2 10227.8 10290.6 10416.2 10630.8 10120.5 10347.9 10449.4 10495.5 10658.7 7368.6 7537.7 7546.4 7567.8 7569.6 7662.6 8157.6 8219.5 8230.0 9807.1 02:49:22 INFO - PROCESS | 3508 | 02:49:22 INFO - PROCESS | 3508 | [#3] mootools.html Cycles:180 Average:5970.74 Median:5194.38 stddev:3114.01 (59.9%) stddev-sans-first:3104.28 02:49:22 INFO - PROCESS | 3508 | Values: 1458.6 1532.1 1545.6 1569.3 1625.6 7472.4 8026.7 8127.5 8157.0 8172.3 7947.4 8077.7 8091.6 8101.6 8112.8 2138.1 2193.8 2405.9 2431.1 2445.6 2434.0 2456.4 2462.9 2465.7 2466.3 2422.9 2441.2 2450.1 2452.6 2463.4 2408.6 2435.4 2453.0 2456.0 2456.9 2413.4 2432.2 2441.0 2451.9 2453.6 8435.7 8470.2 8495.7 8500.0 8507.7 5145.8 5169.8 5219.0 5267.8 5269.1 3205.2 3224.7 3395.6 3413.8 3421.8 1197.0 1208.3 1220.0 1225.7 1251.5 11941.7 11942.6 11957.0 11961.0 11967.6 4757.7 4773.3 4792.1 4825.9 4843.1 10246.0 10247.6 10249.7 10256.9 10258.5 5271.7 5287.2 5300.9 5310.5 5311.1 4733.1 4785.2 4813.9 4815.3 4841.2 3662.9 3718.4 3944.3 3962.9 4026.4 1257.2 1271.2 1285.5 1304.4 1313.3 1365.6 1375.2 1380.1 1397.0 1402.2 7804.2 7832.1 7833.6 7833.6 7837.8 1185.2 1186.1 1203.4 1209.7 1231.0 6113.9 6171.5 6178.7 6187.8 6191.7 9975.8 10252.5 10519.6 10629.3 10653.2 10324.3 10492.8 10517.0 10525.8 10527.4 7861.5 8023.0 8023.5 8065.3 8101.8 7789.8 7795.6 7833.1 7836.7 7840.2 8918.2 9104.8 9218.8 9416.9 9426.2 9062.0 9176.3 9451.3 9581.8 9583.1 6322.3 7386.0 7509.1 7520.9 7521.3 7046.7 7218.5 8041.4 8146.4 8178.8 7617.1 7671.8 7710.5 7716.7 7978.7 7715.3 7781.4 7788.5 7796.4 7857.3 8013.0 8051.1 8052.0 8070.5 8078.4 6923.8 7101.7 7244.0 7256.7 7278.9 7103.5 7124.7 7130.5 7145.1 7154.4 02:49:22 INFO - PROCESS | 3508 | 02:49:22 INFO - PROCESS | 3508 | [#4] prototype.html Cycles:180 Average:5306.40 Median:5990.84 stddev:1557.42 (26.0%) stddev-sans-first:1517.07 02:49:22 INFO - PROCESS | 3508 | Values: 369.9 381.4 382.5 383.2 387.7 5751.9 5857.6 5873.4 5913.7 5974.7 5645.4 5844.4 5888.4 5915.7 5916.1 4650.9 4656.6 4661.9 4663.3 4665.0 4463.6 4597.6 4599.7 4601.3 4660.4 4501.3 4591.8 4604.0 4631.9 4656.3 4605.5 4625.1 4631.5 4632.6 4642.9 4139.4 4143.6 4145.0 4150.9 4151.4 5533.4 5629.7 5637.6 5638.3 5639.4 5387.6 5389.5 5399.3 5400.1 5401.6 5942.0 6256.4 6263.6 6264.2 6266.5 4431.0 4442.1 4488.2 4509.5 4514.0 6481.7 6511.8 6522.3 6525.8 6545.4 4683.7 4694.6 4695.3 4698.6 4704.2 4498.8 4617.4 4626.7 4761.9 4764.4 5264.1 5269.3 5271.0 5341.8 5347.7 6322.7 6324.9 6325.3 6331.4 6332.1 1621.4 1648.9 1650.0 1650.4 1651.1 1128.9 1132.2 1137.7 1139.0 1153.6 6150.4 6158.7 6159.1 6160.1 6165.7 6457.9 6468.6 6474.7 6476.2 6478.6 6017.6 6115.2 6129.8 6138.0 6151.4 3473.2 3504.9 3506.3 3508.8 3511.6 6717.2 6732.1 6734.3 6735.7 6735.8 6538.9 6629.4 6653.4 6663.0 6670.8 6672.9 6691.1 6710.3 6710.6 6718.8 6217.6 6397.1 6423.4 6439.7 6450.8 6416.4 6432.5 6438.1 6439.3 6451.5 6752.4 6752.9 6756.6 6759.2 6760.2 4519.0 4592.5 4593.9 4601.0 4612.1 6486.7 6502.4 6505.3 6506.7 6508.3 6349.3 6358.7 6364.0 6366.1 6368.0 6204.0 6331.4 6336.1 6345.8 6350.3 6232.7 6238.8 6245.1 6245.6 6245.7 6289.2 6305.1 6309.5 6315.7 6365.3 6007.0 6140.2 6143.2 6231.2 6258.4 02:49:22 INFO - PROCESS | 3508 | 02:49:22 INFO - PROCESS | 3508 | [#5] yui.html Cycles:180 Average:15125.55 Median:48281.52 stddev:17494.63 (36.2%) stddev-sans-first:17510.82 02:49:22 INFO - PROCESS | 3508 | Values: 840.2 863.7 922.6 925.9 938.6 14001.9 14199.2 14225.9 14243.6 14246.3 13785.7 13846.2 13849.2 13849.9 13857.7 754.5 771.6 910.2 919.1 927.4 913.1 915.0 922.2 924.1 933.7 795.6 955.9 956.0 956.2 965.9 802.0 949.5 950.0 955.9 956.0 704.4 709.0 709.7 710.6 710.9 12731.9 12754.9 12801.4 12816.4 12822.8 13715.3 14017.6 14096.0 14120.0 14732.8 11548.4 11645.2 11710.4 11714.0 11740.6 4002.6 4014.4 4049.2 4059.8 4065.6 52403.0 52445.2 52511.7 53229.2 53417.5 11594.7 11689.6 11784.2 11836.4 11938.3 20611.6 20728.5 20744.9 20797.7 20811.7 8451.2 8501.9 8534.6 8582.7 8610.7 4818.3 4843.3 4862.7 4862.7 4971.9 3194.7 3217.5 3219.6 3222.8 3229.1 577.3 589.6 592.2 599.5 607.8 571.4 619.3 668.4 692.4 706.7 9296.0 9423.3 9521.7 9672.0 9847.6 541.3 640.5 695.4 752.8 755.5 4325.1 4423.0 4440.5 4473.3 4590.1 61951.0 63984.7 64186.4 64208.0 64397.0 54736.0 54938.5 56459.2 57416.6 58183.0 48251.5 49492.5 50161.0 51836.0 52185.7 9193.6 9477.2 9684.7 9690.4 9791.4 35643.6 37088.3 37378.4 37700.1 37953.8 48311.5 49054.0 49131.3 49150.5 50423.2 12088.6 12247.7 12377.8 12405.6 12515.7 13362.3 13408.5 13425.6 13429.6 13630.7 10917.8 11136.9 11453.9 11488.7 12705.8 12258.3 12544.4 12675.5 12987.9 13339.3 12685.9 13186.2 13457.3 13538.9 13710.7 9928.2 10146.9 10187.8 10251.4 10724.9 10591.6 10651.8 10765.6 10786.8 10800.2 02:49:22 INFO - PROCESS | 3508 | -------- Summary: end -------- 02:49:22 INFO - PROCESS | 3508 | 02:49:23 INFO - TEST-INFO | 3508: exit 0 02:49:23 INFO - TEST-OK | dromaeo_css | took 1117890ms 02:49:23 INFO - TEST-START | kraken 02:49:23 INFO - operating with platform_type : linux_ 02:49:23 INFO - Initialising browser for kraken test... 02:49:23 INFO - TEST-INFO | started process 3703 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptLu_3_/profile http://localhost:44923/getInfo.html) 02:49:28 INFO - PROCESS | 3703 | __metrics Screen width/height:1600/1200 02:49:28 INFO - PROCESS | 3703 | colorDepth:24 02:49:28 INFO - PROCESS | 3703 | Browser inner width/height: 1024/697 02:49:28 INFO - PROCESS | 3703 | __metrics 02:49:28 INFO - PROCESS | 3703 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:49:29 INFO - TEST-INFO | 3703: exit 0 02:49:29 INFO - Browser initialized. 02:49:29 INFO - Running cycle 1/1 for kraken test... 02:49:29 INFO - TEST-INFO | started process 3795 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptLu_3_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:49:41 INFO - PROCESS | 3795 | RSS: Main: 137961472 02:49:41 INFO - PROCESS | 3795 | 02:49:43 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:44923/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44923/tests/kraken/driver.html?testName=audio-beat-detection) 02:49:44 INFO - PROCESS | 3795 | RSS: Main: 169496576 02:49:44 INFO - PROCESS | 3795 | 02:49:47 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:44923/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44923/tests/kraken/driver.html?testName=audio-dft) 02:49:47 INFO - PROCESS | 3795 | RSS: Main: 168271872 02:49:47 INFO - PROCESS | 3795 | 02:49:50 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:44923/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44923/tests/kraken/driver.html?testName=audio-fft) 02:49:51 INFO - PROCESS | 3795 | RSS: Main: 167501824 02:49:51 INFO - PROCESS | 3795 | 02:49:53 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:44923/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44923/tests/kraken/driver.html?testName=audio-oscillator) 02:49:53 INFO - PROCESS | 3795 | RSS: Main: 168251392 02:49:53 INFO - PROCESS | 3795 | 02:49:55 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:44923/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44923/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:49:56 INFO - PROCESS | 3795 | RSS: Main: 166268928 02:49:56 INFO - PROCESS | 3795 | 02:49:59 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:44923/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44923/tests/kraken/driver.html?testName=imaging-darkroom) 02:49:59 INFO - PROCESS | 3795 | RSS: Main: 165158912 02:49:59 INFO - PROCESS | 3795 | 02:50:03 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:44923/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44923/tests/kraken/driver.html?testName=imaging-desaturate) 02:50:03 INFO - PROCESS | 3795 | RSS: Main: 166883328 02:50:03 INFO - PROCESS | 3795 | 02:50:06 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:44923/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44923/tests/kraken/driver.html?testName=json-parse-financial) 02:50:07 INFO - PROCESS | 3795 | RSS: Main: 166621184 02:50:07 INFO - PROCESS | 3795 | 02:50:09 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:44923/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44923/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:50:09 INFO - PROCESS | 3795 | RSS: Main: 170672128 02:50:09 INFO - PROCESS | 3795 | 02:50:11 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:44923/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44923/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:50:12 INFO - PROCESS | 3795 | RSS: Main: 168165376 02:50:12 INFO - PROCESS | 3795 | 02:50:14 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:44923/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44923/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:50:14 INFO - PROCESS | 3795 | RSS: Main: 176160768 02:50:14 INFO - PROCESS | 3795 | 02:50:17 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:44923/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44923/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:50:18 INFO - PROCESS | 3795 | RSS: Main: 181620736 02:50:18 INFO - PROCESS | 3795 | 02:50:20 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:44923/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44923/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:50:21 INFO - PROCESS | 3795 | RSS: Main: 181092352 02:50:21 INFO - PROCESS | 3795 | 02:50:22 INFO - PROCESS | 3795 | Cycle 1(1): loaded http://localhost:44923/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44923/tests/kraken/driver.html?testName=ai-astar) 02:50:23 INFO - PROCESS | 3795 | RSS: Main: 241340416 02:50:23 INFO - PROCESS | 3795 | 02:50:23 INFO - PROCESS | 3795 | __start_tp_report 02:50:23 INFO - PROCESS | 3795 | _x_x_mozilla_page_load 02:50:23 INFO - PROCESS | 3795 | _x_x_mozilla_page_load_details 02:50:23 INFO - PROCESS | 3795 | |i|pagename|runs| 02:50:23 INFO - PROCESS | 3795 | |0;ai-astar;110;111;105;110;111;111;102;110;110;109 02:50:23 INFO - PROCESS | 3795 | |1;audio-beat-detection;159;125;150;168;125;147;171;124;167;127 02:50:23 INFO - PROCESS | 3795 | |2;audio-dft;159;159;160;159;160;162;160;161;161;161 02:50:23 INFO - PROCESS | 3795 | |3;audio-fft;76;73;74;142;73;81;72;76;157;72 02:50:23 INFO - PROCESS | 3795 | |4;audio-oscillator;95;94;140;95;94;96;140;94;96;141 02:50:23 INFO - PROCESS | 3795 | |5;imaging-gaussian-blur;108;109;109;108;109;109;110;109;109;110 02:50:23 INFO - PROCESS | 3795 | |6;imaging-darkroom;146;146;145;146;146;148;146;146;145;145 02:50:23 INFO - PROCESS | 3795 | |7;imaging-desaturate;95;96;96;96;96;96;96;95;95;95 02:50:23 INFO - PROCESS | 3795 | |8;json-parse-financial;52;53;52;53;54;53;53;53;51;52 02:50:23 INFO - PROCESS | 3795 | |9;json-stringify-tinderbox;64;64;64;66;65;66;65;66;65;64 02:50:23 INFO - PROCESS | 3795 | |10;stanford-crypto-aes;79;82;79;86;80;79;80;80;79;81 02:50:23 INFO - PROCESS | 3795 | |11;stanford-crypto-ccm;113;113;120;110;115;109;111;109;112;123 02:50:23 INFO - PROCESS | 3795 | |12;stanford-crypto-pbkdf2;126;127;137;145;134;136;141;140;136;131 02:50:23 INFO - PROCESS | 3795 | |13;stanford-crypto-sha256-iterative;64;66;64;65;64;63;65;65;65;66 02:50:23 INFO - PROCESS | 3795 | __end_tp_report 02:50:23 INFO - PROCESS | 3795 | __start_cc_report 02:50:23 INFO - PROCESS | 3795 | _x_x_mozilla_cycle_collect,926 02:50:23 INFO - PROCESS | 3795 | __end_cc_report 02:50:23 INFO - PROCESS | 3795 | __startTimestamp1456656623074__endTimestamp 02:50:23 INFO - PROCESS | 3795 | 02:50:23 INFO - PROCESS | 3795 | ------- Summary: start ------- 02:50:23 INFO - PROCESS | 3795 | Number of tests: 14 02:50:23 INFO - PROCESS | 3795 | 02:50:23 INFO - PROCESS | 3795 | [#0] ai-astar Cycles:10 Average:108.90 Median:110.00 stddev:3.00 (2.7%) stddev-sans-first:3.15 02:50:23 INFO - PROCESS | 3795 | Values: 110.0 111.0 105.0 110.0 111.0 111.0 102.0 110.0 110.0 109.0 02:50:23 INFO - PROCESS | 3795 | 02:50:23 INFO - PROCESS | 3795 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:154.50 stddev:19.61 (12.7%) stddev-sans-first:20.26 02:50:23 INFO - PROCESS | 3795 | Values: 159.0 125.0 150.0 168.0 125.0 147.0 171.0 124.0 167.0 127.0 02:50:23 INFO - PROCESS | 3795 | 02:50:23 INFO - PROCESS | 3795 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 02:50:23 INFO - PROCESS | 3795 | Values: 159.0 159.0 160.0 159.0 160.0 162.0 160.0 161.0 161.0 161.0 02:50:23 INFO - PROCESS | 3795 | 02:50:23 INFO - PROCESS | 3795 | [#3] audio-fft Cycles:10 Average:89.60 Median:73.50 stddev:31.88 (43.4%) stddev-sans-first:33.43 02:50:23 INFO - PROCESS | 3795 | Values: 76.0 73.0 74.0 142.0 73.0 81.0 72.0 76.0 157.0 72.0 02:50:23 INFO - PROCESS | 3795 | 02:50:23 INFO - PROCESS | 3795 | [#4] audio-oscillator Cycles:10 Average:108.50 Median:94.50 stddev:21.98 (23.3%) stddev-sans-first:22.77 02:50:23 INFO - PROCESS | 3795 | Values: 95.0 94.0 140.0 95.0 94.0 96.0 140.0 94.0 96.0 141.0 02:50:23 INFO - PROCESS | 3795 | 02:50:23 INFO - PROCESS | 3795 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 02:50:23 INFO - PROCESS | 3795 | Values: 108.0 109.0 109.0 108.0 109.0 109.0 110.0 109.0 109.0 110.0 02:50:23 INFO - PROCESS | 3795 | 02:50:23 INFO - PROCESS | 3795 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 02:50:23 INFO - PROCESS | 3795 | Values: 146.0 146.0 145.0 146.0 146.0 148.0 146.0 146.0 145.0 145.0 02:50:23 INFO - PROCESS | 3795 | 02:50:23 INFO - PROCESS | 3795 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 02:50:23 INFO - PROCESS | 3795 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 02:50:23 INFO - PROCESS | 3795 | 02:50:23 INFO - PROCESS | 3795 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:0.84 (1.6%) stddev-sans-first:0.87 02:50:23 INFO - PROCESS | 3795 | Values: 52.0 53.0 52.0 53.0 54.0 53.0 53.0 53.0 51.0 52.0 02:50:23 INFO - PROCESS | 3795 | 02:50:23 INFO - PROCESS | 3795 | [#9] json-stringify-tinderbox Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 02:50:23 INFO - PROCESS | 3795 | Values: 64.0 64.0 64.0 66.0 65.0 66.0 65.0 66.0 65.0 64.0 02:50:23 INFO - PROCESS | 3795 | 02:50:23 INFO - PROCESS | 3795 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.00 stddev:2.17 (2.7%) stddev-sans-first:2.24 02:50:23 INFO - PROCESS | 3795 | Values: 79.0 82.0 79.0 86.0 80.0 79.0 80.0 80.0 79.0 81.0 02:50:23 INFO - PROCESS | 3795 | 02:50:23 INFO - PROCESS | 3795 | [#11] stanford-crypto-ccm Cycles:10 Average:113.50 Median:113.00 stddev:4.67 (4.1%) stddev-sans-first:4.95 02:50:23 INFO - PROCESS | 3795 | Values: 113.0 113.0 120.0 110.0 115.0 109.0 111.0 109.0 112.0 123.0 02:50:23 INFO - PROCESS | 3795 | 02:50:23 INFO - PROCESS | 3795 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.30 Median:136.50 stddev:6.04 (4.4%) stddev-sans-first:5.39 02:50:23 INFO - PROCESS | 3795 | Values: 126.0 127.0 137.0 145.0 134.0 136.0 141.0 140.0 136.0 131.0 02:50:23 INFO - PROCESS | 3795 | 02:50:23 INFO - PROCESS | 3795 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.70 Median:65.00 stddev:0.95 (1.5%) stddev-sans-first:0.97 02:50:23 INFO - PROCESS | 3795 | Values: 64.0 66.0 64.0 65.0 64.0 63.0 65.0 65.0 65.0 66.0 02:50:23 INFO - PROCESS | 3795 | -------- Summary: end -------- 02:50:23 INFO - PROCESS | 3795 | 02:50:23 INFO - TEST-INFO | 3795: exit 0 02:50:23 INFO - TEST-OK | kraken | took 60641ms 02:50:23 INFO - TEST-START | v8_7 02:50:23 INFO - operating with platform_type : linux_ 02:50:23 INFO - Initialising browser for v8_7 test... 02:50:23 INFO - TEST-INFO | started process 4048 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWiM4N9/profile http://localhost:44923/getInfo.html) 02:50:28 INFO - PROCESS | 4048 | __metrics Screen width/height:1600/1200 02:50:28 INFO - PROCESS | 4048 | colorDepth:24 02:50:28 INFO - PROCESS | 4048 | Browser inner width/height: 1024/697 02:50:28 INFO - PROCESS | 4048 | __metrics 02:50:28 INFO - PROCESS | 4048 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:50:30 INFO - TEST-INFO | 4048: exit 0 02:50:30 INFO - Browser initialized. 02:50:30 INFO - Running cycle 1/1 for v8_7 test... 02:50:30 INFO - TEST-INFO | started process 4138 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWiM4N9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:50:42 INFO - PROCESS | 4138 | RSS: Main: 137404416 02:50:42 INFO - PROCESS | 4138 | 02:51:04 INFO - PROCESS | 4138 | Cycle 1(1): loaded http://localhost:44923/tests/v8_7/run.html (next: http://localhost:44923/tests/v8_7/run.html) 02:51:04 INFO - PROCESS | 4138 | RSS: Main: 421949440 02:51:04 INFO - PROCESS | 4138 | 02:51:04 INFO - PROCESS | 4138 | __start_tp_report 02:51:04 INFO - PROCESS | 4138 | _x_x_mozilla_page_load 02:51:04 INFO - PROCESS | 4138 | _x_x_mozilla_page_load_details 02:51:04 INFO - PROCESS | 4138 | |i|pagename|runs| 02:51:04 INFO - PROCESS | 4138 | |0;Richards;166.333998669328 02:51:04 INFO - PROCESS | 4138 | |1;DeltaBlue;170.76502732240436 02:51:04 INFO - PROCESS | 4138 | |2;Encrypt;279.01785714285717 02:51:04 INFO - PROCESS | 4138 | |3;Decrypt;5196.891191709845 02:51:04 INFO - PROCESS | 4138 | |4;RayTrace;957.8544061302682 02:51:04 INFO - PROCESS | 4138 | |5;Earley;576.036866359447 02:51:04 INFO - PROCESS | 4138 | |6;Boyer;11133.333333333334 02:51:04 INFO - PROCESS | 4138 | |7;RegExp;39634.61538461538 02:51:04 INFO - PROCESS | 4138 | |8;Splay;536.9877594465141 02:51:04 INFO - PROCESS | 4138 | |9;NavierStokes;4812.5 02:51:04 INFO - PROCESS | 4138 | __end_tp_report 02:51:04 INFO - PROCESS | 4138 | __startTimestamp1456656664880__endTimestamp 02:51:04 INFO - PROCESS | 4138 | 02:51:04 INFO - PROCESS | 4138 | ------- Summary: start ------- 02:51:04 INFO - PROCESS | 4138 | Number of tests: 10 02:51:04 INFO - PROCESS | 4138 | 02:51:04 INFO - PROCESS | 4138 | [#0] Richards Cycles:1 Average:166.33 Median:166.33 stddev:0.00 (0.0%) 02:51:04 INFO - PROCESS | 4138 | Values: 166.3 02:51:04 INFO - PROCESS | 4138 | 02:51:04 INFO - PROCESS | 4138 | [#1] DeltaBlue Cycles:1 Average:170.77 Median:170.77 stddev:0.00 (0.0%) 02:51:04 INFO - PROCESS | 4138 | Values: 170.8 02:51:04 INFO - PROCESS | 4138 | 02:51:04 INFO - PROCESS | 4138 | [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 02:51:04 INFO - PROCESS | 4138 | Values: 279.0 02:51:04 INFO - PROCESS | 4138 | 02:51:04 INFO - PROCESS | 4138 | [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 02:51:04 INFO - PROCESS | 4138 | Values: 5196.9 02:51:04 INFO - PROCESS | 4138 | 02:51:04 INFO - PROCESS | 4138 | [#4] RayTrace Cycles:1 Average:957.85 Median:957.85 stddev:0.00 (0.0%) 02:51:04 INFO - PROCESS | 4138 | Values: 957.9 02:51:04 INFO - PROCESS | 4138 | 02:51:04 INFO - PROCESS | 4138 | [#5] Earley Cycles:1 Average:576.04 Median:576.04 stddev:0.00 (0.0%) 02:51:04 INFO - PROCESS | 4138 | Values: 576.0 02:51:04 INFO - PROCESS | 4138 | 02:51:04 INFO - PROCESS | 4138 | [#6] Boyer Cycles:1 Average:11133.33 Median:11133.33 stddev:0.00 (0.0%) 02:51:04 INFO - PROCESS | 4138 | Values: 11133.3 02:51:04 INFO - PROCESS | 4138 | 02:51:04 INFO - PROCESS | 4138 | [#7] RegExp Cycles:1 Average:39634.62 Median:39634.62 stddev:0.00 (0.0%) 02:51:04 INFO - PROCESS | 4138 | Values: 39634.6 02:51:04 INFO - PROCESS | 4138 | 02:51:04 INFO - PROCESS | 4138 | [#8] Splay Cycles:1 Average:536.99 Median:536.99 stddev:0.00 (0.0%) 02:51:04 INFO - PROCESS | 4138 | Values: 537.0 02:51:04 INFO - PROCESS | 4138 | 02:51:04 INFO - PROCESS | 4138 | [#9] NavierStokes Cycles:1 Average:4812.50 Median:4812.50 stddev:0.00 (0.0%) 02:51:04 INFO - PROCESS | 4138 | Values: 4812.5 02:51:04 INFO - PROCESS | 4138 | -------- Summary: end -------- 02:51:04 INFO - PROCESS | 4138 | 02:51:05 INFO - TEST-INFO | 4138: exit 0 02:51:05 INFO - TEST-OK | v8_7 | took 41806ms 02:51:05 INFO - SUITE-END | took 1220s 02:51:05 INFO - Completed test suite (00:20:20) 02:51:05 INFO - Working with test: dromaeo_css 02:51:05 INFO - Generating results file: dromaeo_css 02:51:05 INFO - Working with test: kraken 02:51:05 INFO - Generating results file: kraken 02:51:05 INFO - javascript benchmark 02:51:05 INFO - Working with test: v8_7 02:51:05 INFO - Generating results file: v8_7 02:51:05 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:51:05 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,35]] 02:51:05 INFO - process_Request line: dromaeo_css 7320.89 graph.html#tests=[[72,52,35]] 02:51:05 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:51:05 INFO - process_Request line: kraken 1475.50 graph.html#tests=[[232,52,35]] 02:51:05 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:51:05 INFO - process_Request line: v8_7 21811.22 graph.html#tests=[[230,52,35]] 02:51:05 INFO - RETURN: dromaeo_css: 7320.89 02:51:05 INFO - RETURN: kraken: 1475.50 02:51:05 INFO - RETURN: v8_7: 21811.22 02:51:05 INFO - javascript benchmark 02:51:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3156.684331566843, 3210.2295449092194, 3233.9514907276393, 3248.0, 3276.0171948415477, 5066.316047333609, 5072.365954255718, 5101.846944591659, 5103.719295438749, 5127.051495473335, 5076.85770701592, 5095.235714642806, 5096.082705113078, 5123.359580052494, 5129.0767661820855, 4605.884852878688, 4652.069586082788, 4670.953290467086, 4705.129551033053, 4719.90560188796, 4659.697119687209, 4677.345171675968, 4700.858974230779, 4702.0, 4707.693999890013, 4657.4876763555985, 4729.810807567693, 4804.543568361, 4838.612910967132, 4846.0, 4752.976235118819, 4785.1386750384745, 4806.086843499724, 4807.807687692488, 4834.540718631724, 4703.576678098988, 4721.881952951169, 4740.217864052427, 4749.216379297412, 4782.521747825224, 4900.313956046157, 4914.63140264478, 4982.676126051795, 4997.350344455234, 5058.873528161788, 5509.47659972302, 5514.503694667499, 5515.806946756885, 5532.723363831833, 5557.416471270499, 5491.670499769986, 5537.916931246034, 5550.639208451437, 5553.194786755938, 5564.805231816867, 5009.724465154415, 5118.97440512795, 5191.195364718475, 5212.55693266069, 5218.686878787209, 5622.550195984311, 5637.126245431965, 5637.633553818989, 5639.351474580476, 5643.689597072118, 5415.079436495806, 5419.132938729863, 5423.918641220384, 5424.159255315432, 5428.240046393508, 5406.297181366397, 5440.700761458079, 5463.262459567987, 5493.587980901449, 5593.328800543879, 5447.945520544744, 5469.699166545878, 5474.534664553478, 5474.562035037187, 5483.506484416342, 5381.461853814665, 5394.703291319015, 5397.595180361489, 5423.891522169613, 5470.617056806065, 4240.448741663564, 4256.616904478612, 4296.2696341621995, 4299.527052024275, 4319.265724826724, 3859.073822282632, 3876.7092468064443, 3890.085829830044, 3909.354956432157, 3910.6089391061237, 5114.769835357418, 5237.3453318335205, 5252.579793616502, 5257.842264732064, 5274.736263186825, 5367.033933891859, 5461.808836690697, 5509.559235261169, 5511.944880551143, 5541.362743284493, 5169.405518365361, 5190.221466779938, 5209.348831396075, 5209.843704688866, 5253.527182553588, 4699.271612900006, 4725.810967561328, 4788.856334309976, 4794.089123066607, 4804.447488538863, 5636.802711905064, 5689.658620482702, 5711.171880077449, 5724.713764311768, 5757.65454072757, 5469.2616496772425, 5504.174373843795, 5505.091659876076, 5505.889882202414, 5518.724063796874, 5571.554275657856, 5657.858553536194, 5670.914936275876, 5701.515371193329, 5742.741576628978, 5443.7278136092245, 5448.427915068861, 5450.0, 5457.699826509422, 5462.098753705594, 5508.944910550843, 5510.531604813636, 5511.972440137773, 5522.22688823573, 5546.667199968015, 5254.816081437131, 5339.3058902342445, 5350.384705758887, 5394.9460505394445, 5463.0, 5360.0619891518045, 5365.356157261153, 5373.247745315737, 5375.973120134374, 5378.031954248273, 5276.023935571931, 5279.10255256615, 5283.524482796567, 5285.127953887565, 5306.177542480922, 5227.58179345659, 5333.493318134771, 5360.892782144413, 5415.350157981067, 5480.671159730429, 5310.920336194883, 5315.495027972336, 5317.069512835315, 5326.254324394666, 5331.280277162534], "unit": "score", "name": "dojo.html", "value": 5092.427532522989}, {"lowerIsBetter": false, "replicates": [546.0880329849151, 557.0474488624452, 564.1227890630071, 582.7348556406836, 583.6498101139317, 30492.847535762317, 31282.0, 39849.00377490561, 40223.59776402235, 40328.0, 42673.57326426735, 43040.56959430405, 43136.137277254435, 43174.78412607933, 43210.351844722274, 8706.129387061306, 8990.64037438505, 8994.68518601849, 9001.909980900205, 9004.729858104267, 8623.267022303111, 8658.87011694825, 8753.474791512497, 8757.211850933414, 8758.0, 9020.45877247364, 9072.27421806254, 9083.954580227122, 9088.863667044967, 9104.726858194264, 8952.328575356842, 9012.819743605156, 9013.819723605524, 9016.549172541347, 9017.864732029026, 8943.50810705411, 9110.407823491452, 9118.04260552639, 9126.041765614647, 9126.634934602607, 42789.78605106955, 43173.0, 43245.78377108126, 43250.78374608138, 43382.56617433817, 3579.713622910187, 3842.737876724481, 3859.247446747885, 4005.8798236052967, 4126.463559737245, 32519.83740081308, 32859.17852053694, 33035.834820825985, 33044.0, 33062.17344566381, 4299.72051816634, 4376.168527979674, 4380.846670366522, 4399.604035636776, 4480.059187570614, 272957.0, 273209.0, 273760.0, 274069.0, 274314.0, 59681.701591491765, 64547.35452645507, 64860.0, 64919.67540162364, 65023.0, 53440.73279633577, 70166.298337017, 71263.6436817823, 71339.28660713327, 71407.6429617859, 17768.28926842912, 17881.463556093076, 18039.368622098427, 18291.26834926588, 18320.358787442376, 13560.118592291667, 13745.587632371045, 14256.786148207786, 14345.354459049368, 14419.134851908919, 21190.15239390438, 21743.34769956904, 21769.782302176776, 21858.234961776263, 21935.341939741833, 7954.767011113287, 8203.71287004964, 8244.670213191404, 8333.8333233335, 8387.706430274911, 1087.075985412393, 1164.3537836500655, 1195.2947760821157, 1237.1834589171103, 1275.9234445933273, 30416.0, 30661.387680924203, 31007.379852403275, 31601.36797264042, 31795.364092718017, 1194.8685644579089, 1198.3708553009565, 1243.894268987128, 1303.7066660001424, 1311.010187308576, 14619.415223391157, 16332.75500867488, 16541.58646033859, 16677.08276044829, 16852.494425167264, 388411.11588884314, 391724.0, 392252.0, 392291.0, 392547.0, 58373.0, 58742.0, 58746.0, 58773.11840322398, 58833.11750323749, 1369.8493165751759, 1426.9571912842423, 1515.2953876447284, 1518.9240537973058, 1529.2048134969975, 27667.308317292227, 27939.58090628683, 28103.297417564725, 31038.68961310358, 31531.68468315379, 46618.06763864771, 47084.05831883412, 47109.76445117752, 47114.0, 47198.87605057712, 317301.0, 318050.0, 332614.0, 338713.0, 339165.0, 33248.501272481415, 33501.32997340088, 33537.16157096092, 33695.0, 33722.156946076546, 48009.87935784163, 48445.0, 48514.51485485241, 49126.75436622794, 49674.254886177456, 39092.60907391003, 40037.19925601414, 40253.1949361017, 40711.38932916068, 41080.0, 38512.80743596264, 40258.597414026655, 40323.395149073374, 40477.39283910685, 40834.59165408308, 36858.078548036516, 37077.6292237085, 37771.43342849804, 42022.78988605038, 42142.0, 34205.48691769576, 35062.12344691403, 36268.27463450769, 36966.445503316936, 37217.44173837449, 24943.501129977663, 25063.49873002566, 25217.243482695547, 25255.74744252534, 25455.0], "unit": "score", "name": "ext.html", "value": 20024.14714524813}, {"lowerIsBetter": false, "replicates": [394.44974260906037, 398.0685196639863, 398.6571548468317, 400.43738547340996, 400.47937681014673, 13252.734945301088, 17002.65994680107, 17503.212355444004, 17504.562385940357, 18820.71768923464, 17286.827131728678, 17479.563010924732, 17499.65000699985, 17499.73750393742, 17570.648587028252, 5905.586608937366, 6082.847928801793, 6088.391160883921, 6094.725737341808, 6127.5404344674325, 5819.53443724501, 5965.88068238635, 6046.697665116749, 6049.788257410992, 6074.240719910012, 4598.126355992367, 4734.479207287196, 6104.877902441948, 6148.446639802417, 6559.212894452672, 6312.905306420407, 6507.837304067412, 6638.203415590112, 6640.734370625193, 6890.586564806077, 6608.933910660928, 6630.370114839083, 6638.93361066388, 6655.968324909647, 6661.800145995628, 22139.225127120633, 22433.66349504759, 22604.434889127904, 22669.546609067726, 23152.305430837103, 2354.117206047732, 2428.295794219674, 2452.3623857796924, 2474.381404648838, 2511.1713134665515, 14068.085574437731, 14475.015324200347, 14496.710065798625, 14752.041117327446, 15005.849941500554, 2053.4558342039372, 2095.7275554178013, 2115.862468939514, 2126.2345555599973, 2137.9786202137934, 66801.0, 67119.3288067118, 67178.9999999995, 67924.66037669829, 68728.6563567179, 14913.105213687213, 14915.105093694414, 14943.850561494246, 14947.103173809388, 14968.700625987638, 22592.209272675707, 22720.772792271866, 22792.658110128363, 22832.429189270068, 22848.65727014096, 9098.681546145854, 9143.085691430937, 9145.771355716028, 9170.0, 9262.16640502358, 7870.29167374939, 7887.447878648554, 7915.722949696733, 7944.483608565541, 7955.204479552114, 7032.33192846689, 7068.858622827514, 7099.89350159748, 7110.893336599956, 7230.855382892418, 2513.773760361576, 3027.848607569613, 3043.4521786078717, 3136.2943337748825, 3149.937001259962, 965.9420434773936, 1000.1448761309122, 1052.9578816847393, 1070.9518071686794, 1193.4152265389896, 16625.7506137408, 16652.250648720837, 16826.663466730595, 17045.659086818443, 17089.401870934456, 1033.4574348467115, 1062.9893701063045, 1078.223678951154, 1092.191778084212, 1123.7078359626555, 9970.152537034288, 10313.48432578368, 10411.687649370531, 10412.635557755593, 10435.37387756737, 348407.0, 349592.0, 350916.0, 476008.0, 557380.0, 48682.51317486851, 63411.0, 72234.27765722276, 76165.61917190379, 82388.58805706054, 1176.9470373833199, 1206.7586482703493, 1211.7758214730304, 1213.696575856036, 1219.378117160237, 15394.692106158038, 15400.691986160438, 15654.45209417665, 15712.607184820014, 15861.920690396475, 33993.490097648064, 34252.48621270633, 34274.65725342715, 35238.823805880806, 35601.28797424089, 46189.53810461852, 46211.76894115508, 46385.0, 46653.0, 49469.25796112989, 7057.329553692391, 7165.641717914188, 7262.382697470563, 7500.099988001475, 7709.537427754352, 11357.148213884157, 11516.481758320728, 11538.711532211762, 11694.356810375511, 11829.290242585128, 9655.068986202647, 9743.756406089904, 9892.060254275832, 10274.589016439259, 10287.53706083243, 10014.198864091, 10227.846582301123, 10290.588376464857, 10416.166706663296, 10630.787384252426, 10120.493975301059, 10347.94826025865, 10449.373037617766, 10495.527701253615, 10658.73353166177, 7368.557886526825, 7537.736179233701, 7546.358559522502, 7567.810804729926, 7569.621518924142, 7662.616869156632, 8157.592120394075, 8219.506829590244, 8230.0, 9807.117359437685], "unit": "score", "name": "jquery.html", "value": 9259.501798095303}, {"lowerIsBetter": false, "replicates": [1458.6426325550242, 1532.1496569403982, 1545.5595155380718, 1569.270289315468, 1625.5529729324435, 7472.4395670324675, 8026.678932842687, 8127.471714338579, 8156.980377452818, 8172.264496195348, 7947.403944704156, 8077.717279895191, 8091.595420228994, 8101.5544145072, 8112.837743245132, 2138.112683236463, 2193.846430749848, 2405.939851503718, 2431.1369463840347, 2445.6209287560455, 2433.9543075434703, 2456.435019945414, 2462.9261122166363, 2465.704115506142, 2466.2971053249826, 2422.8667423291713, 2441.1578005588044, 2450.1179575352858, 2452.583060879646, 2463.3718401807605, 2408.5784987627185, 2435.3668046308, 2452.982012464825, 2456.0298682020593, 2456.852588844675, 2413.3966508372905, 2432.246003738829, 2441.0, 2451.8651474168914, 2453.570625140611, 8435.746927592181, 8470.195331443503, 8495.74512764618, 8500.0, 8507.659693612248, 5145.794168233266, 5169.793208271664, 5218.9739051304505, 5267.841964741026, 5269.051570717269, 3205.214722393005, 3224.7097761201603, 3395.5585773849243, 3413.7781044232047, 3421.81180035098, 1197.0, 1208.2569219929767, 1219.9817002744967, 1225.6874497003296, 1251.5056552661647, 11941.701457463547, 11942.582009629708, 11957.0, 11960.983316418202, 11967.64097077089, 4757.738324392122, 4773.260144677511, 4792.0895029944195, 4825.9034819303415, 4843.128236917389, 10246.026627470379, 10247.590096396061, 10249.743756406, 10256.948715256525, 10258.487075646188, 5271.683698978073, 5287.23335116406, 5300.867478313073, 5310.468953104659, 5311.123664595299, 4733.053389322081, 4785.210440277316, 4813.855584332476, 4815.3499277597775, 4841.225403935354, 3662.853485860536, 3718.4050551912105, 3944.2900277950243, 3962.920741585152, 4026.416169655384, 1257.2456526084277, 1271.2182008064974, 1285.5243559882904, 1304.373900527752, 1313.2842600782596, 1365.6312795545346, 1375.2367436072875, 1380.0753495158267, 1397.0, 1402.2427888940063, 7804.180561041123, 7832.0601527817025, 7833.5691536966015, 7833.64748586315, 7837.843243135106, 1185.2177562808677, 1186.129566449195, 1203.4366798718672, 1209.7036226124656, 1231.0274882842634, 6113.908291375633, 6171.537134714914, 6178.69106544671, 6187.81436556904, 6191.690415479298, 9975.800483990279, 10252.487375631337, 10519.579216831242, 10629.255952083435, 10653.201009924287, 10324.277300588887, 10492.790144197073, 10517.0, 10525.84211236832, 10527.420991845522, 7861.52830830152, 8023.037235531773, 8023.4784738991775, 8065.314448271963, 8101.797455063553, 7789.844203115793, 7795.571243581658, 7833.060032795873, 7836.725714599962, 7840.176781437867, 8918.19736223717, 9104.772380690536, 9218.769530761785, 9416.905830941603, 9426.151646351862, 9061.95469022677, 9176.311776616914, 9451.338406311492, 9581.760455988377, 9583.137517623447, 6322.336154703874, 7386.0, 7509.136449308399, 7520.8871866920945, 7521.285477879593, 7046.718131274692, 7218.458615603956, 8041.43709940322, 8146.429749917449, 8178.754637360888, 7617.085949686073, 7671.808204794925, 7710.498817576839, 7716.729914452967, 7978.720744773905, 7715.344195743424, 7781.416393770377, 7788.493747906368, 7796.415268854745, 7857.292843643871, 8012.959935200287, 8051.074126475531, 8052.033755949324, 8070.47541909774, 8078.353731701567, 6923.7576684817805, 7101.680424381018, 7244.0, 7256.673449694882, 7278.890816637649, 7103.502754807114, 7124.679389427592, 7130.500864939404, 7145.1425828900865, 7154.356107950101], "unit": "score", "name": "mootools.html", "value": 4905.2776814366225}, {"lowerIsBetter": false, "replicates": [369.9019759763662, 381.3536056384428, 382.455001622688, 383.2258837148958, 387.72084099448404, 5751.942480575193, 5857.56068294878, 5873.353931067584, 5913.674747888865, 5974.701264936757, 5645.350784659765, 5844.415558444153, 5888.41115888411, 5915.733791979361, 5916.053431450969, 4650.883787890907, 4656.580907718305, 4661.86014419568, 4663.27719203524, 4665.043666048469, 4463.6429085673235, 4597.60920321773, 4599.678022538407, 4601.33280674302, 4660.394148760656, 4501.324801279801, 4591.816327346902, 4604.0, 4631.861044168681, 4656.324832899228, 4605.4933957264675, 4625.098105869357, 4631.467381251132, 4632.559906808848, 4642.930356044662, 4139.379093136024, 4143.647789937859, 4144.958550414518, 4150.937735933963, 4151.356539736345, 5533.363663178746, 5629.690367029812, 5637.577181711347, 5638.323401191842, 5639.379668236491, 5387.595930305243, 5389.514943655051, 5399.325084364455, 5400.054990376669, 5401.567874570025, 5941.970290148522, 6256.405641464054, 6263.561550691454, 6264.1543391642, 6266.49868010558, 4431.003024319502, 4442.111577684444, 4488.236999710057, 4509.549045095464, 4514.0, 6481.708323125471, 6511.837204069936, 6522.282548919615, 6525.804225873231, 6545.443637290884, 4683.6721429500285, 4694.647901407408, 4695.3426520287185, 4698.553637404441, 4704.223803072523, 4498.797554110073, 4617.422822147231, 4626.653001024936, 4761.857144285677, 4764.38063051808, 5264.105102132647, 5269.314989051475, 5271.0, 5341.813036543703, 5347.705876176769, 6322.652254125976, 6324.873502529924, 6325.272593651697, 6331.430171284606, 6332.081848131995, 1621.391978008247, 1648.934042638281, 1649.9505014849574, 1650.4388507907129, 1651.1331550935854, 1128.853249077631, 1132.1565433751907, 1137.70988397958, 1139.0318229504855, 1153.6193056291404, 6150.446459818549, 6158.661273629993, 6159.076138579159, 6160.10678451622, 6165.722542485599, 6457.935420645734, 6468.579542329733, 6474.6762661866715, 6476.190476190476, 6478.578892371981, 6017.6389416634265, 6115.174451448997, 6129.816105516842, 6137.96931015351, 6151.415615516519, 3473.218525831718, 3504.9474257886154, 3506.3337965786927, 3508.7719298245534, 3511.5610548681416, 6717.227518835396, 6732.057511948331, 6734.292899245509, 6735.696893639798, 6735.797926062226, 6538.869222615521, 6629.436497897636, 6653.401193892573, 6663.0, 6670.799876003728, 6672.899906501407, 6691.063251144844, 6710.261871194165, 6710.563813352116, 6718.8320291993095, 6217.595856269328, 6397.104405383343, 6423.42189202974, 6439.710213040331, 6450.774222902176, 6416.390442907917, 6432.517561182836, 6438.066480360415, 6439.259485159267, 6451.451626611791, 6752.426043786333, 6752.93247067523, 6756.628385438848, 6759.222689390783, 6760.22257440381, 4519.0, 4592.494825569118, 4593.885152871071, 4601.010782681739, 4612.146752850734, 6486.675666216576, 6502.414782669583, 6505.2844187138435, 6506.707198175999, 6508.349165083454, 6349.301576826638, 6358.682065896779, 6364.0, 6366.140571022853, 6368.044793281045, 6204.0, 6331.398517140864, 6336.081268216175, 6345.809625711236, 6350.333215012357, 6232.688365581794, 6238.781642642486, 6245.063240513778, 6245.594036387621, 6245.7189426476825, 6289.213848268966, 6305.054241863757, 6309.4952403806665, 6315.715792789244, 6365.267994180728, 6006.969965150146, 6140.20177376956, 6143.232095988002, 6231.189945307262, 6258.405451482102], "unit": "score", "name": "prototype.html", "value": 4817.533458980907}, {"lowerIsBetter": false, "replicates": [840.2185967050644, 863.689071934104, 922.6125027488454, 925.8657494663274, 938.5635679409074, 14001.859981400183, 14199.219042952633, 14225.92887035566, 14243.643908902257, 14246.287685615716, 13785.655358616039, 13846.169229846217, 13849.238291893942, 13849.930750346233, 13857.653558661013, 754.543501181784, 771.6450432800918, 910.1808372464801, 919.0855099176296, 927.429630777074, 913.0549880873298, 914.9679761208359, 922.1608336413865, 924.0528458330198, 933.6825479337024, 795.5942469340649, 955.928305377096, 956.0, 956.1872408452829, 965.884093908732, 801.9839603207932, 949.5015117063527, 949.9715008549755, 955.8757361543024, 956.0, 704.4470090978608, 709.0, 709.6806437103324, 710.5523520182252, 710.8613820305043, 12731.936340318332, 12754.872451275462, 12801.359932003363, 12816.423260953186, 12822.80765788514, 13715.314234288246, 14017.649558761113, 14096.0, 14120.0, 14732.779008314883, 11548.422578871106, 11645.243059201124, 11710.414479276002, 11714.0, 11740.64778056651, 4002.639762421367, 4014.41790940312, 4049.2104039712267, 4059.817308221137, 4065.5731148229306, 52403.0, 52445.213321800205, 52511.73744131255, 53229.2015619766, 53417.46582534203, 11594.721716734897, 11689.649310520697, 11784.234024788362, 11836.408179590986, 11938.28370297785, 20611.58776824485, 20728.48178795512, 20744.89627551883, 20797.688034679493, 20811.68782468264, 8451.23938845507, 8501.872471912926, 8534.573271336409, 8582.699605513777, 8610.6986255482, 4818.325434439182, 4843.321934929113, 4862.6839255448285, 4862.70823750569, 4971.850844474671, 3194.6805319467867, 3217.4530329843983, 3219.5814544109116, 3222.8227447490144, 3229.0797122819886, 577.3187638586425, 589.6373730156009, 592.2330581896455, 599.4574909706722, 607.7872744539376, 571.3743450921235, 619.2661695890384, 668.4351722794231, 692.3699433515477, 706.6502081469705, 9295.953520232355, 9423.293253006052, 9521.714348569554, 9672.0, 9847.55685994132, 541.2963147907705, 640.5228105061666, 695.4471195399669, 752.8280909575913, 755.5089192025227, 4325.113351762881, 4422.955770442254, 4440.533743956903, 4473.329000649864, 4590.081983603226, 61951.0, 63984.68007659932, 64186.358136418974, 64208.0, 64397.0, 54736.0, 54938.450615494134, 56459.153112703345, 57416.55500669973, 58183.0, 48251.517484824704, 49492.50507494951, 50161.0, 51836.0, 52185.73907130516, 9193.586288616894, 9477.24182065447, 9684.661036863676, 9690.418574885529, 9791.363561368487, 35643.64356356507, 37088.258234835695, 37378.43932341071, 37700.057498561655, 37953.81023094867, 48311.5168848307, 49054.0, 49131.263031053844, 49150.50849491602, 50423.24365134599, 12088.637340879788, 12247.69380765488, 12377.814332784836, 12405.62783116508, 12515.74968500643, 13362.265075420944, 13408.530701425403, 13425.597232083053, 13429.597112086652, 13630.659233519242, 10917.836232456679, 11136.888631113585, 11453.885461145283, 11488.712782180512, 12705.809412859, 12258.325792081521, 12544.372781360713, 12675.492980281055, 12987.870121298665, 13339.266340351374, 12685.936570317459, 13186.208827470382, 13457.327133643474, 13538.93230533841, 13710.725785484434, 9928.156106731009, 10146.898531014594, 10187.84718229242, 10251.38491690501, 10724.8927510727, 10591.576336946744, 10651.840222396826, 10765.569377224823, 10786.784264314827, 10800.24398292112], "unit": "score", "name": "yui.html", "value": 6899.021044006326}], "name": "dromaeo_css", "value": 7320.886028559229}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 105.0, 110.0, 111.0, 111.0, 102.0, 110.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.9}, {"lowerIsBetter": true, "replicates": [159.0, 125.0, 150.0, 168.0, 125.0, 147.0, 171.0, 124.0, 167.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 146.3}, {"lowerIsBetter": true, "replicates": [159.0, 159.0, 160.0, 159.0, 160.0, 162.0, 160.0, 161.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.2}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 74.0, 142.0, 73.0, 81.0, 72.0, 76.0, 157.0, 72.0], "unit": "score", "name": "audio-fft", "value": 89.6}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 140.0, 95.0, 94.0, 96.0, 140.0, 94.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 108.5}, {"lowerIsBetter": true, "replicates": [108.0, 109.0, 109.0, 108.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 145.0, 146.0, 146.0, 148.0, 146.0, 146.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [52.0, 53.0, 52.0, 53.0, 54.0, 53.0, 53.0, 53.0, 51.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 52.6}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.9}, {"lowerIsBetter": true, "replicates": [79.0, 82.0, 79.0, 86.0, 80.0, 79.0, 80.0, 80.0, 79.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.5}, {"lowerIsBetter": true, "replicates": [113.0, 113.0, 120.0, 110.0, 115.0, 109.0, 111.0, 109.0, 112.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.5}, {"lowerIsBetter": true, "replicates": [126.0, 127.0, 137.0, 145.0, 134.0, 136.0, 141.0, 140.0, 136.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.3}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 64.0, 65.0, 64.0, 63.0, 65.0, 65.0, 65.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.7}], "name": "kraken", "value": 1475.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.333998669328], "unit": "score", "name": "Richards", "value": 212.23562399999997}, {"lowerIsBetter": false, "replicates": [170.76502732240436], "unit": "score", "name": "DeltaBlue", "value": 387.18700800000016}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [957.8544061302682], "unit": "score", "name": "RayTrace", "value": 772.5485159999996}, {"lowerIsBetter": false, "replicates": [576.036866359447], "unit": "score", "name": "Earley", "value": 1156.9797679999995}, {"lowerIsBetter": false, "replicates": [11133.333333333334], "unit": "score", "name": "Boyer", "value": 59.86194610778439}, {"lowerIsBetter": false, "replicates": [39634.61538461538], "unit": "score", "name": "RegExp", "value": 22.98458030082485}, {"lowerIsBetter": false, "replicates": [536.9877594465141], "unit": "score", "name": "Splay", "value": 151.75578691774027}, {"lowerIsBetter": false, "replicates": [4812.5], "unit": "score", "name": "NavierStokes", "value": 308.3636363636364}], "name": "v8_7", "value": 21811.21737323794}]} 02:51:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,35]]", "result": "21811.22"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,35]]", "result": "1475.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,35]]", "result": "7320.89"}}} 02:51:06 INFO - Return code: 0 02:51:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:51:06 INFO - # TBPL SUCCESS # 02:51:06 INFO - Running post-action listener: _resource_record_post_action 02:51:06 INFO - Running post-run listener: _resource_record_post_run 02:51:07 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 8032256; Write bytes: 396029952; Read time: 2852; Write time: 1095152 02:51:07 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 6627328; Read time: 0; Write time: 776 02:51:07 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 6139904; Write bytes: 389402624; Read time: 2264; Write time: 1094376 02:51:07 INFO - Running post-run listener: _upload_blobber_files 02:51:07 INFO - Blob upload gear active. 02:51:07 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 02:51:07 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 02:51:07 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-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 02:51:07 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-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 02:51:07 INFO - (blobuploader) - INFO - Open directory for files ... 02:51:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:51:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:51:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:51:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:51:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:51:08 INFO - (blobuploader) - INFO - Done attempting. 02:51:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 02:51:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:51:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:51:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:51:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:51:09 INFO - (blobuploader) - INFO - Done attempting. 02:51:09 INFO - (blobuploader) - INFO - Iteration through files over. 02:51:09 INFO - Return code: 0 02:51:09 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 02:51:09 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 02:51:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c954724ecaf415e1e60f66b7ac6aacc3cfdd707fe991ef9239d1cd8c8ac6803dfae3fd1ef1f82c80e574309f4b3f7bd2741efb8a0b3363a34dfea155f2ad4e54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/784b3c5de9e9d2cc1e86e59a9638011c322ea9fef5612d98d69cf93010d244b6f38c1c9392e1eb20c6296301583b0316154a3770bd87871bbab39bd4a356a245"} 02:51:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 02:51:09 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 02:51:09 INFO - Contents: 02:51:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c954724ecaf415e1e60f66b7ac6aacc3cfdd707fe991ef9239d1cd8c8ac6803dfae3fd1ef1f82c80e574309f4b3f7bd2741efb8a0b3363a34dfea155f2ad4e54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/784b3c5de9e9d2cc1e86e59a9638011c322ea9fef5612d98d69cf93010d244b6f38c1c9392e1eb20c6296301583b0316154a3770bd87871bbab39bd4a356a245"} 02:51:09 INFO - Running post-run listener: copy_logs_to_upload_dir 02:51:09 INFO - Copying logs to upload dir... 02:51:09 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 02:51:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.443619 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2016-02-28 02:51:09.504714) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-28 02:51:09.508377) ========= 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=8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360 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-Aurora/sha512/c954724ecaf415e1e60f66b7ac6aacc3cfdd707fe991ef9239d1cd8c8ac6803dfae3fd1ef1f82c80e574309f4b3f7bd2741efb8a0b3363a34dfea155f2ad4e54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/784b3c5de9e9d2cc1e86e59a9638011c322ea9fef5612d98d69cf93010d244b6f38c1c9392e1eb20c6296301583b0316154a3770bd87871bbab39bd4a356a245"} build_url:https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/dPOZBOuAQmSCS7sfTBWyew/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c954724ecaf415e1e60f66b7ac6aacc3cfdd707fe991ef9239d1cd8c8ac6803dfae3fd1ef1f82c80e574309f4b3f7bd2741efb8a0b3363a34dfea155f2ad4e54", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/784b3c5de9e9d2cc1e86e59a9638011c322ea9fef5612d98d69cf93010d244b6f38c1c9392e1eb20c6296301583b0316154a3770bd87871bbab39bd4a356a245"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-28 02:51:09.532476) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:51:09.532799) ========= 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=8783db0840cc980e80bb0bd400000236-1456652885.171494-1654861360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 02:51:09.616637) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-28 02:51:09.616953) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-28 02:51:09.617224) ========= ========= Total master_lag: 0.30 =========