builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-048 starttime: 1459479254.9 results: success (0) buildid: 20160331170046 builduid: bba7f9ccdf684cd8b550caf5b704c503 revision: abc5d4c8f0da153a12cdf0740b40b9331039f803 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:14.899404) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:14.899996) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:14.900363) ========= 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=fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006462 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.08 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:14.988340) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:14.988725) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:15.772669) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:15.772949) ========= 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=fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.028435 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:15.894779) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:15.895460) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:15.896084) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:15.896359) ========= 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=fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-31 19:54:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.1M=0s 2016-03-31 19:54:16 (50.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.484425 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:16.456388) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:16.456717) ========= 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=fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.095165 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:16.600556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-31 19:54:16.600878) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev abc5d4c8f0da153a12cdf0740b40b9331039f803 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev abc5d4c8f0da153a12cdf0740b40b9331039f803 --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=fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-31 19:54:16,781 truncating revision to first 12 chars 2016-03-31 19:54:16,781 Setting DEBUG logging. 2016-03-31 19:54:16,781 attempt 1/10 2016-03-31 19:54:16,781 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/abc5d4c8f0da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-31 19:54:17,474 unpacking tar archive at: mozilla-beta-abc5d4c8f0da/testing/mozharness/ program finished with exit code 0 elapsedTime=1.289815 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-31 19:54:17.941018) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:17.941368) ========= echo abc5d4c8f0da153a12cdf0740b40b9331039f803 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'abc5d4c8f0da153a12cdf0740b40b9331039f803'] 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=fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False abc5d4c8f0da153a12cdf0740b40b9331039f803 program finished with exit code 0 elapsedTime=0.004818 script_repo_revision: 'abc5d4c8f0da153a12cdf0740b40b9331039f803' ========= master_lag: 0.13 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:18.079055) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:18.079354) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-31 19:54:18.262924) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 12 secs) (at 2016-03-31 19:54:18.263321) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:54:18 INFO - MultiFileLogger online at 20160331 19:54:18 in /builds/slave/test-pgo 19:54:18 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 19:54:18 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 19:54:18 INFO - {'append_to_log': False, 19:54:18 INFO - 'base_work_dir': '/builds/slave/test-pgo', 19:54:18 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:54:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 19:54:18 INFO - 'branch': 'Mozilla-Beta', 19:54:18 INFO - 'buildbot_json_path': 'buildprops.json', 19:54:18 INFO - 'config_files': ('talos/linux_config.py',), 19:54:18 INFO - 'default_actions': ('clobber', 19:54:18 INFO - 'read-buildbot-config', 19:54:18 INFO - 'download-and-extract', 19:54:18 INFO - 'populate-webroot', 19:54:18 INFO - 'create-virtualenv', 19:54:18 INFO - 'install', 19:54:18 INFO - 'run-tests'), 19:54:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:54:18 INFO - 'download_minidump_stackwalk': True, 19:54:18 INFO - 'download_symbols': 'ondemand', 19:54:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:54:18 INFO - 'tooltool.py': '/tools/tooltool.py', 19:54:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:54:18 INFO - '/tools/misc-python/virtualenv.py')}, 19:54:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:54:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:54:18 INFO - 'installer_path': 'installer.exe', 19:54:18 INFO - 'log_level': 'info', 19:54:18 INFO - 'log_name': 'talos', 19:54:18 INFO - 'log_to_console': True, 19:54:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:54:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:54:18 INFO - 'opt_config_files': (), 19:54:18 INFO - 'pip_index': False, 19:54:18 INFO - 'sps_profile': False, 19:54:18 INFO - 'sps_profile_interval': 0, 19:54:18 INFO - 'suite': 'dromaeojs', 19:54:18 INFO - 'system_bits': '32', 19:54:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:54:18 INFO - 'title': 'talos-linux64-ix-048', 19:54:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:54:18 INFO - 'use_talos_json': True, 19:54:18 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 19:54:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:54:18 INFO - 'work_dir': 'build'} 19:54:18 INFO - ##### 19:54:18 INFO - ##### Running clobber step. 19:54:18 INFO - ##### 19:54:18 INFO - Running pre-action listener: _resource_record_pre_action 19:54:18 INFO - Running main action method: clobber 19:54:18 INFO - rmtree: /builds/slave/test-pgo/build 19:54:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 19:54:19 INFO - Running post-action listener: _resource_record_post_action 19:54:19 INFO - ##### 19:54:19 INFO - ##### Running read-buildbot-config step. 19:54:19 INFO - ##### 19:54:19 INFO - Running pre-action listener: _resource_record_pre_action 19:54:19 INFO - Running main action method: read_buildbot_config 19:54:19 INFO - Using buildbot properties: 19:54:19 INFO - { 19:54:19 INFO - "project": "", 19:54:19 INFO - "product": "firefox", 19:54:19 INFO - "script_repo_revision": "production", 19:54:19 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 19:54:19 INFO - "repository": "", 19:54:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 19:54:19 INFO - "buildid": "20160331170046", 19:54:19 INFO - "pgo_build": "True", 19:54:19 INFO - "basedir": "/builds/slave/test-pgo", 19:54:19 INFO - "buildnumber": 184, 19:54:19 INFO - "slavename": "talos-linux64-ix-048", 19:54:19 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:54:19 INFO - "platform": "ubuntu64_hw", 19:54:19 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 19:54:19 INFO - "branch": "mozilla-beta", 19:54:19 INFO - "repo_path": "releases/mozilla-beta", 19:54:19 INFO - "revision": "abc5d4c8f0da153a12cdf0740b40b9331039f803", 19:54:19 INFO - "stage_platform": "linux64-pgo", 19:54:19 INFO - "builduid": "bba7f9ccdf684cd8b550caf5b704c503", 19:54:19 INFO - "slavebuilddir": "test" 19:54:19 INFO - } 19:54:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 19:54:19 INFO - Running post-action listener: _resource_record_post_action 19:54:19 INFO - ##### 19:54:19 INFO - ##### Running download-and-extract step. 19:54:19 INFO - ##### 19:54:19 INFO - Running pre-action listener: _resource_record_pre_action 19:54:19 INFO - Running main action method: download_and_extract 19:54:19 INFO - mkdir: /builds/slave/test-pgo/build/tests 19:54: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')]} 19:54:19 INFO - https://queue.taskcluster.net/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:54:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/test_packages.json 19:54:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/test_packages.json 19:54:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 19:54:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 19:54:25 INFO - Downloaded 1412 bytes. 19:54:25 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 19:54:25 INFO - Using the following test package requirements: 19:54:25 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 19:54:25 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 19:54:25 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 19:54:25 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 19:54:25 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 19:54:25 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 19:54:25 INFO - u'jsshell-linux-x86_64.zip'], 19:54:25 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 19:54:25 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 19:54:25 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 19:54:25 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 19:54:25 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 19:54:25 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 19:54:25 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 19:54:25 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 19:54:25 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 19:54:25 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 19:54:25 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 19:54:25 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 19:54:25 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:54: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')]} 19:54:25 INFO - https://queue.taskcluster.net/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:54:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 19:54:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 19:54:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 19:54:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:55:53 INFO - Downloaded 23141030 bytes. 19:55:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:55:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:55:55 INFO - Return code: 0 19:55:55 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:55:55 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')]} 19:55:55 INFO - https://queue.taskcluster.net/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:55:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 19:55:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 19:55:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 19:55:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:56:05 INFO - Downloaded 23141030 bytes. 19:56:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:56:05 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 19:56:06 INFO - Return code: 0 19:56: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')]} 19:56:06 INFO - https://queue.taskcluster.net/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:56:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 19:56:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 19:56:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 19:56:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:56:18 INFO - Downloaded 10801548 bytes. 19:56:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 19:56:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 19:56:18 INFO - Return code: 0 19:56:18 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')]} 19:56:18 INFO - https://queue.taskcluster.net/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:56:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 19:56:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 19:56:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 19:56:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:00:32 INFO - Downloaded 52865042 bytes. 20:00:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 20:00:32 INFO - mkdir: /builds/slave/test-pgo/properties 20:00:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 20:00:32 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 20:00:32 INFO - Contents: 20:00:32 INFO - build_url:https://queue.taskcluster.net/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 20:00:34 INFO - Running post-action listener: _resource_record_post_action 20:00:34 INFO - Running post-action listener: set_extra_try_arguments 20:00:34 INFO - ##### 20:00:34 INFO - ##### Running populate-webroot step. 20:00:34 INFO - ##### 20:00:34 INFO - Running pre-action listener: _resource_record_pre_action 20:00:34 INFO - Running main action method: populate_webroot 20:00:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:00:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:00:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:00:34 INFO - '--tppagecycles', 20:00:34 INFO - '7'], 20:00:34 INFO - 'tests': ['tsvgm']}}, 20:00:34 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:00:34 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:00:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:00:34 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:00:34 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:00:34 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:00:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:00:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:34 INFO - 'talos_options': ['--e10s'], 20:00:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:00:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:34 INFO - 'tests': ['damp', 'tps']}, 20:00:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:34 INFO - 'talos_options': ['--e10s'], 20:00:34 INFO - 'tests': ['damp', 'tps']}, 20:00:34 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:00:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:00:34 INFO - 'other': {'tests': ['a11yr', 20:00:34 INFO - 'ts_paint', 20:00:34 INFO - 'tpaint', 20:00:34 INFO - 'sessionrestore', 20:00:34 INFO - 'sessionrestore_no_auto_restore']}, 20:00:34 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:00:34 INFO - 'tests': ['a11yr', 20:00:34 INFO - 'ts_paint', 20:00:34 INFO - 'tpaint', 20:00:34 INFO - 'sessionrestore', 20:00:34 INFO - 'sessionrestore_no_auto_restore']}, 20:00:34 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:00:34 INFO - 'tests': ['a11yr', 20:00:34 INFO - 'ts_paint', 20:00:34 INFO - 'tpaint', 20:00:34 INFO - 'sessionrestore', 20:00:34 INFO - 'sessionrestore_no_auto_restore']}, 20:00:34 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:00:34 INFO - 'tests': ['a11yr', 20:00:34 INFO - 'ts_paint', 20:00:34 INFO - 'tpaint', 20:00:34 INFO - 'sessionrestore', 20:00:34 INFO - 'sessionrestore_no_auto_restore']}, 20:00:34 INFO - 'other_l64': {'tests': ['a11yr', 20:00:34 INFO - 'ts_paint', 20:00:34 INFO - 'tpaint', 20:00:34 INFO - 'sessionrestore', 20:00:34 INFO - 'sessionrestore_no_auto_restore']}, 20:00:34 INFO - 'other_nol64': {'tests': ['a11yr', 20:00:34 INFO - 'ts_paint', 20:00:34 INFO - 'tpaint', 20:00:34 INFO - 'sessionrestore', 20:00:34 INFO - 'sessionrestore_no_auto_restore']}, 20:00:34 INFO - 'svgr': {'tests': ['tsvgx', 20:00:34 INFO - 'tsvgr_opacity', 20:00:34 INFO - 'tart', 20:00:34 INFO - 'tscrollx', 20:00:34 INFO - 'cart']}, 20:00:34 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:00:34 INFO - 'tests': ['tsvgx', 20:00:34 INFO - 'tsvgr_opacity', 20:00:34 INFO - 'tart', 20:00:34 INFO - 'tscrollx', 20:00:34 INFO - 'cart']}, 20:00:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:34 INFO - 'tests': ['tp5o']}, 20:00:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:34 INFO - 'talos_options': ['--e10s'], 20:00:34 INFO - 'tests': ['tp5o']}, 20:00:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:34 INFO - 'talos_options': ['--xperf_path', 20:00:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:00:34 INFO - 'tests': ['tp5n']}, 20:00:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:00:34 INFO - 'talos_options': ['--e10s', 20:00:34 INFO - '--xperf_path', 20:00:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:00:34 INFO - 'tests': ['tp5n']}}, 20:00:34 INFO - 'talos.zip': {'path': '', 20:00:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:00:34 INFO - Running post-action listener: _resource_record_post_action 20:00:34 INFO - ##### 20:00:34 INFO - ##### Running create-virtualenv step. 20:00:34 INFO - ##### 20:00:34 INFO - Running pre-action listener: _resource_record_pre_action 20:00:34 INFO - Running main action method: create_virtualenv 20:00:34 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 20:00:34 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 20:00:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 20:00:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:00:34 INFO - Using real prefix '/usr' 20:00:34 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 20:00:34 INFO - Installing distribute.............................................................................................................................................................................................done. 20:00:36 INFO - Installing pip.................done. 20:00:36 INFO - Return code: 0 20:00:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 20:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2252210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148850>, '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 0x20b4330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47c0>, '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': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', '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 20:00:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 20:00:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:00:36 INFO - Using env: {'DISPLAY': ':0', 20:00:36 INFO - 'HOME': '/home/cltbld', 20:00:36 INFO - 'LANG': 'en_US.UTF-8', 20:00:36 INFO - 'LANGUAGE': 'en_US:en', 20:00:36 INFO - 'LOGNAME': 'cltbld', 20:00:36 INFO - 'MAIL': '/var/mail/cltbld', 20:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:36 INFO - 'MOZ_NO_REMOTE': '1', 20:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:36 INFO - 'NO_EM_RESTART': '1', 20:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:36 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:36 INFO - 'SHELL': '/bin/bash', 20:00:36 INFO - 'SHLVL': '1', 20:00:36 INFO - 'TERM': 'linux', 20:00:36 INFO - 'TMOUT': '86400', 20:00:36 INFO - 'USER': 'cltbld', 20:00:36 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', 20:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:36 INFO - '_': '/tools/buildbot/bin/python'} 20:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:36 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 20:00:36 INFO - Cleaning up... 20:00:36 INFO - Return code: 0 20:00:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 20:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2252210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148850>, '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 0x20b4330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47c0>, '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': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', '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 20:00:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 20:00:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:00:36 INFO - Using env: {'DISPLAY': ':0', 20:00:36 INFO - 'HOME': '/home/cltbld', 20:00:36 INFO - 'LANG': 'en_US.UTF-8', 20:00:36 INFO - 'LANGUAGE': 'en_US:en', 20:00:36 INFO - 'LOGNAME': 'cltbld', 20:00:36 INFO - 'MAIL': '/var/mail/cltbld', 20:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:36 INFO - 'MOZ_NO_REMOTE': '1', 20:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:36 INFO - 'NO_EM_RESTART': '1', 20:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:36 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:36 INFO - 'SHELL': '/bin/bash', 20:00:36 INFO - 'SHLVL': '1', 20:00:36 INFO - 'TERM': 'linux', 20:00:36 INFO - 'TMOUT': '86400', 20:00:36 INFO - 'USER': 'cltbld', 20:00:36 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', 20:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:36 INFO - '_': '/tools/buildbot/bin/python'} 20:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:37 INFO - Downloading/unpacking psutil>=0.7.1 20:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 20:00:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:00:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:00:40 INFO - Installing collected packages: psutil 20:00:40 INFO - Running setup.py install for psutil 20:00:40 INFO - building 'psutil._psutil_linux' extension 20:00:40 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 20:00:40 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 20:00:40 INFO - building 'psutil._psutil_posix' extension 20:00:40 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 20:00:40 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 20:00:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:00:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:00:40 INFO - Successfully installed psutil 20:00:40 INFO - Cleaning up... 20:00:40 INFO - Return code: 0 20:00:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 20:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:40 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 0x7f2252210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148850>, '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 0x20b4330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47c0>, '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': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', '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 20:00:40 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 20:00:40 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 20:00:40 INFO - Using env: {'DISPLAY': ':0', 20:00:40 INFO - 'HOME': '/home/cltbld', 20:00:40 INFO - 'LANG': 'en_US.UTF-8', 20:00:40 INFO - 'LANGUAGE': 'en_US:en', 20:00:40 INFO - 'LOGNAME': 'cltbld', 20:00:40 INFO - 'MAIL': '/var/mail/cltbld', 20:00:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:40 INFO - 'MOZ_NO_REMOTE': '1', 20:00:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:40 INFO - 'NO_EM_RESTART': '1', 20:00:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:40 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:40 INFO - 'SHELL': '/bin/bash', 20:00:40 INFO - 'SHLVL': '1', 20:00:40 INFO - 'TERM': 'linux', 20:00:40 INFO - 'TMOUT': '86400', 20:00:40 INFO - 'USER': 'cltbld', 20:00:40 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', 20:00:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:40 INFO - '_': '/tools/buildbot/bin/python'} 20:00:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:00:40 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 20:00:40 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 20:00:40 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 20:00:40 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 20:00:40 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 20:00:40 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 20:00:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:00:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:00:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:00:43 INFO - Installing collected packages: mozsystemmonitor 20:00:43 INFO - Running setup.py install for mozsystemmonitor 20:00:43 INFO - Successfully installed mozsystemmonitor 20:00:43 INFO - Cleaning up... 20:00:44 INFO - Return code: 0 20:00:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 20:00: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')]} 20:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00: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')]} 20:00:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2252210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148850>, '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 0x20b4330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47c0>, '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': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', '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 20:00:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 20:00:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:00:44 INFO - Using env: {'DISPLAY': ':0', 20:00:44 INFO - 'HOME': '/home/cltbld', 20:00:44 INFO - 'LANG': 'en_US.UTF-8', 20:00:44 INFO - 'LANGUAGE': 'en_US:en', 20:00:44 INFO - 'LOGNAME': 'cltbld', 20:00:44 INFO - 'MAIL': '/var/mail/cltbld', 20:00:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:44 INFO - 'MOZ_NO_REMOTE': '1', 20:00:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:44 INFO - 'NO_EM_RESTART': '1', 20:00:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:44 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:44 INFO - 'SHELL': '/bin/bash', 20:00:44 INFO - 'SHLVL': '1', 20:00:44 INFO - 'TERM': 'linux', 20:00:44 INFO - 'TMOUT': '86400', 20:00:44 INFO - 'USER': 'cltbld', 20:00:44 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', 20:00:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:44 INFO - '_': '/tools/buildbot/bin/python'} 20:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:44 INFO - Downloading/unpacking blobuploader==1.2.4 20:00:44 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 20:00:44 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 20:00:44 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 20:00:44 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 20:00:44 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 20:00:44 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 20:00:46 INFO - Downloading blobuploader-1.2.4.tar.gz 20:00:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:00:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:00:46 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 20:00:46 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 20:00:46 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 20:00:46 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 20:00:46 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 20:00:46 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 20:00:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 20:00:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:47 INFO - Downloading docopt-0.6.1.tar.gz 20:00:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 20:00:47 INFO - Installing collected packages: blobuploader, requests, docopt 20:00:47 INFO - Running setup.py install for blobuploader 20:00:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:00:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 20:00:47 INFO - Running setup.py install for requests 20:00:48 INFO - Running setup.py install for docopt 20:00:48 INFO - Successfully installed blobuploader requests docopt 20:00:48 INFO - Cleaning up... 20:00:48 INFO - Return code: 0 20:00:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:00: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')]} 20:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00: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')]} 20:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:48 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 0x7f2252210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148850>, '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 0x20b4330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47c0>, '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': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', '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 20:00:48 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 20:00:48 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 20:00:48 INFO - Using env: {'DISPLAY': ':0', 20:00:48 INFO - 'HOME': '/home/cltbld', 20:00:48 INFO - 'LANG': 'en_US.UTF-8', 20:00:48 INFO - 'LANGUAGE': 'en_US:en', 20:00:48 INFO - 'LOGNAME': 'cltbld', 20:00:48 INFO - 'MAIL': '/var/mail/cltbld', 20:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:48 INFO - 'MOZ_NO_REMOTE': '1', 20:00:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:48 INFO - 'NO_EM_RESTART': '1', 20:00:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:48 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:48 INFO - 'SHELL': '/bin/bash', 20:00:48 INFO - 'SHLVL': '1', 20:00:48 INFO - 'TERM': 'linux', 20:00:48 INFO - 'TMOUT': '86400', 20:00:48 INFO - 'USER': 'cltbld', 20:00:48 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', 20:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:48 INFO - '_': '/tools/buildbot/bin/python'} 20:00:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:00:48 INFO - Running setup.py (path:/tmp/pip-zHryOS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:00:48 INFO - Running setup.py (path:/tmp/pip-3PgRDz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:00:48 INFO - Running setup.py (path:/tmp/pip-fDYNWH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:00:48 INFO - Running setup.py (path:/tmp/pip-BTvHuJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:00:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:00:48 INFO - Running setup.py (path:/tmp/pip-5oC5eZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:00:49 INFO - Running setup.py (path:/tmp/pip-3HGnKz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:00:49 INFO - Running setup.py (path:/tmp/pip-rHkrIk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:00:49 INFO - Running setup.py (path:/tmp/pip-i230yk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:00:49 INFO - Running setup.py (path:/tmp/pip-E443Us-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:00:49 INFO - Running setup.py (path:/tmp/pip-XhN7G3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:00:49 INFO - Running setup.py (path:/tmp/pip-bSN2me-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:00:49 INFO - Running setup.py (path:/tmp/pip-aK44D3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:00:49 INFO - Running setup.py (path:/tmp/pip-XIY1kt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:00:49 INFO - Running setup.py (path:/tmp/pip-XUUCic-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:00:49 INFO - Running setup.py (path:/tmp/pip-zxSkPS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:00:49 INFO - Running setup.py (path:/tmp/pip-JtBLee-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:00:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:00:49 INFO - Running setup.py (path:/tmp/pip-pQ5atg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:00:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:00:49 INFO - Running setup.py install for manifestparser 20:00:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 20:00:49 INFO - Running setup.py install for mozcrash 20:00:50 INFO - Running setup.py install for mozdebug 20:00:50 INFO - Running setup.py install for mozdevice 20:00:50 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 20:00:50 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 20:00:50 INFO - Running setup.py install for mozfile 20:00:50 INFO - Running setup.py install for mozhttpd 20:00:50 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 20:00:50 INFO - Running setup.py install for mozinfo 20:00:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 20:00:50 INFO - Running setup.py install for mozInstall 20:00:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 20:00:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 20:00:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 20:00:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 20:00:50 INFO - Running setup.py install for mozleak 20:00:50 INFO - Running setup.py install for mozlog 20:00:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 20:00:50 INFO - Running setup.py install for moznetwork 20:00:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 20:00:50 INFO - Running setup.py install for mozprocess 20:00:51 INFO - Running setup.py install for mozprofile 20:00:51 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 20:00:51 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 20:00:51 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 20:00:51 INFO - Running setup.py install for mozrunner 20:00:51 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 20:00:51 INFO - Running setup.py install for mozscreenshot 20:00:51 INFO - Running setup.py install for moztest 20:00:51 INFO - Running setup.py install for mozversion 20:00:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 20:00:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:00:51 INFO - Cleaning up... 20:00:51 INFO - Return code: 0 20:00:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:00:51 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')]} 20:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:51 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')]} 20:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:51 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 0x7f2252210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148850>, '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 0x20b4330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47c0>, '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': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', '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 20:00:51 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 20:00:51 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 20:00:51 INFO - Using env: {'DISPLAY': ':0', 20:00:51 INFO - 'HOME': '/home/cltbld', 20:00:51 INFO - 'LANG': 'en_US.UTF-8', 20:00:51 INFO - 'LANGUAGE': 'en_US:en', 20:00:51 INFO - 'LOGNAME': 'cltbld', 20:00:51 INFO - 'MAIL': '/var/mail/cltbld', 20:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:51 INFO - 'MOZ_NO_REMOTE': '1', 20:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:51 INFO - 'NO_EM_RESTART': '1', 20:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:51 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:51 INFO - 'SHELL': '/bin/bash', 20:00:51 INFO - 'SHLVL': '1', 20:00:51 INFO - 'TERM': 'linux', 20:00:51 INFO - 'TMOUT': '86400', 20:00:51 INFO - 'USER': 'cltbld', 20:00:51 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', 20:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:51 INFO - '_': '/tools/buildbot/bin/python'} 20:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:00:51 INFO - Running setup.py (path:/tmp/pip-EDBzMf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 20:00:51 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)) 20:00:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:00:51 INFO - Running setup.py (path:/tmp/pip-rTF7xN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 20:00:52 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)) 20:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:00:52 INFO - Running setup.py (path:/tmp/pip-BJTiex-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 20:00:52 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)) 20:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:00:52 INFO - Running setup.py (path:/tmp/pip-9P4ozr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 20:00:52 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)) 20:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 20:00:52 INFO - Running setup.py (path:/tmp/pip-Yv5mGj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 20:00:52 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)) 20:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:00:52 INFO - Running setup.py (path:/tmp/pip-v5_0VS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 20:00:52 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)) 20:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:00:52 INFO - Running setup.py (path:/tmp/pip-VWDah3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 20:00:52 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)) 20:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:00:52 INFO - Running setup.py (path:/tmp/pip-v9lzC4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 20:00:52 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)) 20:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 20:00:52 INFO - Running setup.py (path:/tmp/pip-sDpYQj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 20:00:52 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)) 20:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 20:00:52 INFO - Running setup.py (path:/tmp/pip-EltRPV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 20:00:52 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)) 20:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:00:52 INFO - Running setup.py (path:/tmp/pip-Eh710U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 20:00:52 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)) 20:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:00:52 INFO - Running setup.py (path:/tmp/pip-F0BoDZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 20:00:52 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)) 20:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:00:52 INFO - Running setup.py (path:/tmp/pip-G4E9RI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 20:00:52 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)) 20:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:00:52 INFO - Running setup.py (path:/tmp/pip-wqahxH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 20:00:52 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)) 20:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:00:52 INFO - Running setup.py (path:/tmp/pip-dPXIsx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 20:00:52 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)) 20:00:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 20:00:52 INFO - Running setup.py (path:/tmp/pip-G7HDrP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 20:00:53 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)) 20:00:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 20:00:53 INFO - Running setup.py (path:/tmp/pip-f_nqUD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 20:00:53 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)) 20:00:53 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)) 20:00:53 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)) 20:00:53 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)) 20:00:53 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)) 20:00:53 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)) 20:00:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 20:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:55 INFO - Downloading blessings-1.6.tar.gz 20:00:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 20:00:55 INFO - Installing collected packages: blessings 20:00:55 INFO - Running setup.py install for blessings 20:00:55 INFO - Successfully installed blessings 20:00:55 INFO - Cleaning up... 20:00:55 INFO - Return code: 0 20:00:55 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 20:00:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:00:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:00:56 INFO - Reading from file tmpfile_stdout 20:00:56 INFO - Current package versions: 20:00:56 INFO - argparse == 1.2.1 20:00:56 INFO - blessings == 1.6 20:00:56 INFO - blobuploader == 1.2.4 20:00:56 INFO - docopt == 0.6.1 20:00:56 INFO - manifestparser == 1.1 20:00:56 INFO - mozInstall == 1.12 20:00:56 INFO - mozcrash == 0.16 20:00:56 INFO - mozdebug == 0.1 20:00:56 INFO - mozdevice == 0.48 20:00:56 INFO - mozfile == 1.2 20:00:56 INFO - mozhttpd == 0.7 20:00:56 INFO - mozinfo == 0.9 20:00:56 INFO - mozleak == 0.1 20:00:56 INFO - mozlog == 3.1 20:00:56 INFO - moznetwork == 0.27 20:00:56 INFO - mozprocess == 0.22 20:00:56 INFO - mozprofile == 0.28 20:00:56 INFO - mozrunner == 6.11 20:00:56 INFO - mozscreenshot == 0.1 20:00:56 INFO - mozsystemmonitor == 0.0 20:00:56 INFO - moztest == 0.7 20:00:56 INFO - mozversion == 1.4 20:00:56 INFO - psutil == 3.1.1 20:00:56 INFO - requests == 1.2.3 20:00:56 INFO - wsgiref == 0.1.2 20:00:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 20:00:56 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')]} 20:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:56 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')]} 20:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:56 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 0x7f2252210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148850>, '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 0x20b4330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47c0>, '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': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', '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 20:00:56 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 20:00:56 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 20:00:56 INFO - Using env: {'DISPLAY': ':0', 20:00:56 INFO - 'HOME': '/home/cltbld', 20:00:56 INFO - 'LANG': 'en_US.UTF-8', 20:00:56 INFO - 'LANGUAGE': 'en_US:en', 20:00:56 INFO - 'LOGNAME': 'cltbld', 20:00:56 INFO - 'MAIL': '/var/mail/cltbld', 20:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:56 INFO - 'MOZ_NO_REMOTE': '1', 20:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:56 INFO - 'NO_EM_RESTART': '1', 20:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:56 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:56 INFO - 'SHELL': '/bin/bash', 20:00:56 INFO - 'SHLVL': '1', 20:00:56 INFO - 'TERM': 'linux', 20:00:56 INFO - 'TMOUT': '86400', 20:00:56 INFO - 'USER': 'cltbld', 20:00:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', 20:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:56 INFO - '_': '/tools/buildbot/bin/python'} 20:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:56 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)) 20:00:56 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)) 20:00:56 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)) 20:00:56 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)) 20:00:56 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)) 20:00:56 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)) 20:00:56 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)) 20:00:56 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)) 20:00:56 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)) 20:00:56 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)) 20:00:56 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)) 20:00:56 INFO - Cleaning up... 20:00:56 INFO - Return code: 0 20:00:56 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 20:00:56 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')]} 20:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:56 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')]} 20:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:56 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 0x7f2252210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148850>, '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 0x20b4330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47c0>, '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': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', '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 20:00:56 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 20:00:56 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 20:00:56 INFO - Using env: {'DISPLAY': ':0', 20:00:56 INFO - 'HOME': '/home/cltbld', 20:00:56 INFO - 'LANG': 'en_US.UTF-8', 20:00:56 INFO - 'LANGUAGE': 'en_US:en', 20:00:56 INFO - 'LOGNAME': 'cltbld', 20:00:56 INFO - 'MAIL': '/var/mail/cltbld', 20:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:56 INFO - 'MOZ_NO_REMOTE': '1', 20:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:56 INFO - 'NO_EM_RESTART': '1', 20:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:00:56 INFO - 'PWD': '/builds/slave/test-pgo', 20:00:56 INFO - 'SHELL': '/bin/bash', 20:00:56 INFO - 'SHLVL': '1', 20:00:56 INFO - 'TERM': 'linux', 20:00:56 INFO - 'TMOUT': '86400', 20:00:56 INFO - 'USER': 'cltbld', 20:00:56 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', 20:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:56 INFO - '_': '/tools/buildbot/bin/python'} 20:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:56 INFO - Downloading/unpacking jsonschema 20:00:56 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 20:00:56 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 20:00:56 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 20:00:56 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 20:00:56 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 20:00:56 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 20:00:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:01:00 INFO - Downloading/unpacking functools32 (from jsonschema) 20:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:00 INFO - Downloading functools32-3.2.3-2.tar.gz 20:01:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 20:01:00 INFO - warning: no files found matching '*.txt' 20:01:00 INFO - no previously-included directories found matching 'build' 20:01:00 INFO - no previously-included directories found matching 'dist' 20:01:00 INFO - no previously-included directories found matching '.git*' 20:01:00 INFO - Installing collected packages: jsonschema, functools32 20:01:00 INFO - Running setup.py install for functools32 20:01:00 INFO - warning: no files found matching '*.txt' 20:01:00 INFO - no previously-included directories found matching 'build' 20:01:00 INFO - no previously-included directories found matching 'dist' 20:01:00 INFO - no previously-included directories found matching '.git*' 20:01:00 INFO - Successfully installed jsonschema functools32 20:01:00 INFO - Cleaning up... 20:01:00 INFO - Return code: 0 20:01:00 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 20:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:01:00 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2252210f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20b6290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2148850>, '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 0x20b4330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47c0>, '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': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', '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 20:01:00 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 20:01:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:01:00 INFO - Using env: {'DISPLAY': ':0', 20:01:00 INFO - 'HOME': '/home/cltbld', 20:01:00 INFO - 'LANG': 'en_US.UTF-8', 20:01:00 INFO - 'LANGUAGE': 'en_US:en', 20:01:00 INFO - 'LOGNAME': 'cltbld', 20:01:00 INFO - 'MAIL': '/var/mail/cltbld', 20:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:00 INFO - 'MOZ_NO_REMOTE': '1', 20:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:00 INFO - 'NO_EM_RESTART': '1', 20:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:00 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:00 INFO - 'SHELL': '/bin/bash', 20:01:00 INFO - 'SHLVL': '1', 20:01:00 INFO - 'TERM': 'linux', 20:01:00 INFO - 'TMOUT': '86400', 20:01:00 INFO - 'USER': 'cltbld', 20:01:00 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', 20:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:00 INFO - '_': '/tools/buildbot/bin/python'} 20:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:01:00 INFO - Downloading/unpacking flake8 20:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:01:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:01:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:01:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:01:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 20:01:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:01:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:01:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:01:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:01:03 INFO - no previously-included directories found matching 'docs/_build' 20:01:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:01:03 INFO - Running setup.py install for pep8 20:01:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:01:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:01:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:01:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:01:03 INFO - no previously-included directories found matching 'docs/_build' 20:01:03 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 20:01:03 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:01:03 INFO - Cleaning up... 20:01:03 INFO - Return code: 0 20:01:03 INFO - Running post-action listener: _resource_record_post_action 20:01:03 INFO - Running post-action listener: _start_resource_monitoring 20:01:03 INFO - Starting resource monitoring. 20:01:03 INFO - ##### 20:01:03 INFO - ##### Running install step. 20:01:03 INFO - ##### 20:01:03 INFO - Running pre-action listener: _resource_record_pre_action 20:01:03 INFO - Running main action method: install 20:01:03 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 20:01:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 20:01:04 INFO - Reading from file tmpfile_stdout 20:01:04 INFO - Detecting whether we're running mozinstall >=1.0... 20:01:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 20:01:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 20:01:04 INFO - Reading from file tmpfile_stdout 20:01:04 INFO - Output received: 20:01:04 INFO - Usage: mozinstall [options] installer 20:01:04 INFO - Options: 20:01:04 INFO - -h, --help show this help message and exit 20:01:04 INFO - -d DEST, --destination=DEST 20:01:04 INFO - Directory to install application into. [default: 20:01:04 INFO - "/builds/slave/test-pgo"] 20:01:04 INFO - --app=APP Application being installed. [default: firefox] 20:01:04 INFO - mkdir: /builds/slave/test-pgo/build/application 20:01:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 20:01:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 20:01:16 INFO - Reading from file tmpfile_stdout 20:01:16 INFO - Output received: 20:01:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 20:01:16 INFO - Running post-action listener: _resource_record_post_action 20:01:16 INFO - ##### 20:01:16 INFO - ##### Running run-tests step. 20:01:16 INFO - ##### 20:01:16 INFO - Running pre-action listener: _resource_record_pre_action 20:01:16 INFO - Running main action method: run_tests 20:01:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 20:01:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 20:01:16 INFO - Python 2.7.3 20:01:16 INFO - Return code: 0 20:01:16 INFO - grabbing minidump binary from tooltool 20:01: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')]} 20:01:16 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 0x2148850>, '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 0x20b4330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20b47c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 20:01:16 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 20:01:16 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 20:01:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:01:16 INFO - Return code: 0 20:01:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 20:01:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 20:01:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 20:01:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 20:01:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 20:01:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 20:01:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 20:01:17 INFO - Return code: 0 20:01:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 20:01:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 20:01:17 INFO - Using env: {'DISPLAY': ':0', 20:01:17 INFO - 'HOME': '/home/cltbld', 20:01:17 INFO - 'LANG': 'en_US.UTF-8', 20:01:17 INFO - 'LANGUAGE': 'en_US:en', 20:01:17 INFO - 'LOGNAME': 'cltbld', 20:01:17 INFO - 'MAIL': '/var/mail/cltbld', 20:01:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:01:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 20:01:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:01:17 INFO - 'MOZ_NO_REMOTE': '1', 20:01:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 20:01:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:01:17 INFO - 'NO_EM_RESTART': '1', 20:01:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:01:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 20:01:17 INFO - 'PWD': '/builds/slave/test-pgo', 20:01:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 20:01:17 INFO - 'SHELL': '/bin/bash', 20:01:17 INFO - 'SHLVL': '1', 20:01:17 INFO - 'TERM': 'linux', 20:01:17 INFO - 'TMOUT': '86400', 20:01:17 INFO - 'USER': 'cltbld', 20:01:17 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659', 20:01:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:01:17 INFO - '_': '/tools/buildbot/bin/python'} 20:01:17 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 20:01:18 INFO - mozversion application_buildid: 20160331170046 20:01:18 INFO - mozversion application_changeset: abc5d4c8f0da153a12cdf0740b40b9331039f803 20:01:18 INFO - mozversion application_display_name: Firefox 20:01:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:01:18 INFO - mozversion application_name: Firefox 20:01:18 INFO - mozversion application_remotingname: firefox 20:01:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:01:18 INFO - mozversion application_vendor: Mozilla 20:01:18 INFO - mozversion application_version: 46.0 20:01:18 INFO - mozversion platform_buildid: 20160331170046 20:01:18 INFO - mozversion platform_changeset: abc5d4c8f0da153a12cdf0740b40b9331039f803 20:01:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:01:18 INFO - mozversion platform_version: 46.0 20:01:18 INFO - using testdate: 1459479678 20:01:18 INFO - actual date: 1459479678 20:01:18 INFO - starting webserver on 'localhost:48630' 20:01:18 INFO - SUITE-START | Running 3 tests 20:01:18 INFO - TEST-START | dromaeo_css 20:01:18 INFO - operating with platform_type : linux_ 20:01:18 INFO - Initialising browser for dromaeo_css test... 20:01:18 INFO - TEST-INFO | started process 9706 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptVwzRG/profile http://localhost:48630/getInfo.html) 20:01:22 INFO - PROCESS | 9706 | __metrics Screen width/height:1600/1200 20:01:22 INFO - PROCESS | 9706 | colorDepth:24 20:01:22 INFO - PROCESS | 9706 | Browser inner width/height: 1024/697 20:01:22 INFO - PROCESS | 9706 | __metrics 20:01:22 INFO - PROCESS | 9706 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:01:23 INFO - TEST-INFO | 9706: exit 0 20:01:23 INFO - Browser initialized. 20:01:23 INFO - Running cycle 1/1 for dromaeo_css test... 20:01:23 INFO - TEST-INFO | started process 9791 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptVwzRG/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:01:35 INFO - PROCESS | 9791 | RSS: Main: 137379840 20:01:35 INFO - PROCESS | 9791 | 20:02:26 INFO - PROCESS | 9791 | 1459479746886 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] 20:04:33 INFO - PROCESS | 9791 | Cycle 1(1): loaded http://localhost:48630/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48630/tests/dromaeo/cssquery-ext.html) 20:04:34 INFO - PROCESS | 9791 | RSS: Main: 241475584 20:04:34 INFO - PROCESS | 9791 | 20:07:36 INFO - PROCESS | 9791 | Cycle 1(1): loaded http://localhost:48630/tests/dromaeo/cssquery-ext.html (next: http://localhost:48630/tests/dromaeo/cssquery-jquery.html) 20:07:37 INFO - PROCESS | 9791 | RSS: Main: 219418624 20:07:37 INFO - PROCESS | 9791 | 20:10:39 INFO - PROCESS | 9791 | Cycle 1(1): loaded http://localhost:48630/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48630/tests/dromaeo/cssquery-mootools.html) 20:10:40 INFO - PROCESS | 9791 | RSS: Main: 228728832 20:10:40 INFO - PROCESS | 9791 | 20:13:41 INFO - PROCESS | 9791 | Cycle 1(1): loaded http://localhost:48630/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48630/tests/dromaeo/cssquery-prototype.html) 20:13:42 INFO - PROCESS | 9791 | RSS: Main: 197804032 20:13:42 INFO - PROCESS | 9791 | 20:16:44 INFO - PROCESS | 9791 | Cycle 1(1): loaded http://localhost:48630/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48630/tests/dromaeo/cssquery-yui.html) 20:16:45 INFO - PROCESS | 9791 | RSS: Main: 200466432 20:16:45 INFO - PROCESS | 9791 | 20:19:47 INFO - PROCESS | 9791 | Cycle 1(1): loaded http://localhost:48630/tests/dromaeo/cssquery-yui.html (next: http://localhost:48630/tests/dromaeo/cssquery-dojo.html) 20:19:47 INFO - PROCESS | 9791 | RSS: Main: 246525952 20:19:47 INFO - PROCESS | 9791 | 20:19:47 INFO - PROCESS | 9791 | __start_tp_report 20:19:47 INFO - PROCESS | 9791 | _x_x_mozilla_page_load 20:19:47 INFO - PROCESS | 9791 | _x_x_mozilla_page_load_details 20:19:47 INFO - PROCESS | 9791 | |i|pagename|runs| 20:19:47 INFO - PROCESS | 9791 | |0;dojo.html;3189.6810318968105;3236.9352612947728;3261.037993791831;3263.4125857345684;3298.9010329690104;5138;5144.485551444858;5161.122609156443;5169.586433085354;5193.246979188016;5156.071907056728;5162.432132465435;5186.351706036746;5195.246689230059;5214.843554693356;4600.493945665974;4705.647076469261;4733.90532189356;4767.880802979918;4832.879178020543;4701.7414042227665;4705.600023997964;4736.171170045245;4739.573438390544;4746.620270378378;4664.277037059262;4666.346711460398;4701.318308845232;4741.146593613148;4753;4764.452088009872;4798.256270278112;4800.519948005206;4802.375691160162;4804.399450068741;4719.457262414798;4733.958529123587;4750.524947505256;4774.618030557547;4804.807807687688;4915.901681966377;4936;4987.202047672391;5000.799968001275;5003.849884503471;5507.339119305669;5515.448455154453;5521.668699878021;5525.585581081435;5530.557555395559;5382.67703937765;5497.752601132958;5508.834734957918;5540;5562.221289019541;5163.3545806774155;5163.509466600667;5216.66091704038;5221.582273418117;5222.738863056832;5570.359408668055;5600.27196464457;5600.607957443021;5604.467575580314;5623.297087864017;5322.54758345545;5387.81142660005;5392.973035134799;5397.271368365299;5398.1902714593125;5446.291982042309;5479.068558345091;5490.396056433789;5495.642783219078;5526.834194974157;5454.072807622713;5473.67157970523;5474.178873169057;5476.205950137288;5479.835604931858;5288.127458969227;5383.192521121863;5456.045192091368;5477.014137455296;5512.91730624041;4200.369944508348;4243.830246790094;4247.44783178191;4250.702450828412;4254.744715317091;3837.5394952605866;3851.9422208666892;3859.5754467008605;3894.824732887027;3917.6082391760597;5179.533841954242;5200.869978250574;5212.113940630102;5224.216367544823;5239.187925871496;5506.1190209566275;5508.944910550923;5510.834674959758;5512.255845460892;5512.6692398456225;5092.134337162691;5148.56237219833;5163.8192663256605;5203.245529398292;5219.399769026611;4717.363155973968;4734.976325118352;4745.193317136095;4752.691075080109;4777.498362671939;5499.807506737325;5554.666719996813;5596.4403559644525;5605.439456054443;5615.0454422748235;5441.891162176735;5452.318460192476;5493.478119578634;5508.44915508446;5539.196816461671;5490.670559766427;5499.477549632778;5512.035393805988;5512.476314750093;5513.5037846594;5314.760835762478;5330.493603107699;5338.8932221356135;5357.78568857257;5431.321084864392;5518.724063796874;5569.164625306236;5569.916451253153;5572.721363931706;5589.965856316594;5284.867878303073;5330.840074797762;5333.06671332523;5336.3863155736035;5372.677639341652;5271.314729085348;5273.6044796639635;5326.280952071421;5336.893262134658;5357.946420535744;5320.787168513216;5339.065663508948;5341.7062061586985;5344.25180474726;5344.625876188629;5413.7834486620095;5419.701916394636;5428.131498960148;5456.345238571397;5459.535939445032;5153.587712983027;5259.526642602184;5300.1519756838725;5306.230596563554;5388.703621300866 20:19:47 INFO - PROCESS | 9791 | |1;ext.html;552.737449711387;574.0592850096303;578.22517826113;604.5345084285099;606.2936678769235;40589.79705101474;40891.79554102226;40932.181356372894;40964.79517602411;40990;44303.55696443035;44992.550074499246;45095;45102.77448612752;45175.77412112935;8773.56132193391;9124.543772811367;9125.269978401711;9134.588943497525;9149.085091490831;8909.198172164504;9074.546272686339;9085.954570227139;9103.08969103091;9124.863127053066;9082.500462474562;9146.2682985361;9180;9199.172074513292;9202.815943681122;9040.231580315682;9187.081291870827;9197.632094716204;9201.861972070425;9205.217556507705;9027.593758280893;9149.359544831865;9167.541622918827;9169.495677737721;9173.174414302677;44274.33588496175;44743.55256447427;44777;44812.77593612044;44832.775836120934;3502.5796904371637;3610.9277814443826;3937.1928754605237;4072.7556346619003;4218.261804184255;33757.662423375696;34382.48426273608;34544.6545534544;34555.48166777475;34582.65417345819;3901.239258344624;4021.2158629067344;4042.0905296308097;4071.1654110907193;4078.7419639606414;296581;297904;298656.99999999785;298961;298978;62497;63903;69307;70366.42618229799;70605.64697176481;61722.38277617256;61869.69065154645;61971;62095.37904620986;62118.068228976605;17114.315427382764;17338.739918901225;17366.56583585395;17374.739378909326;17379.826201738073;12817.102802803714;12947.482100715866;12962.67593310156;13045.217286962812;13085.084044117011;22226.222082227043;22344.888275558842;22377.32868013962;22381.88809055944;22538;7770.45606807518;8486.575671216538;8560.743177704679;8600.397972142015;8609.612567434355;991.281321042253;1002.3835341265216;1097.2977294531506;1110.655696734015;1155.7052951497315;30878.228044298623;30917.536236956465;31144.22139446532;31848;31922.361552768816;1079.7516571188671;1147.225622704671;1158.8841115888345;1167.3287859480834;1218.939053047344;14141.787873181911;14954.820028955077;14965.92517037408;15414.306356213998;15793.763093553605;364760;370021;370923;371223;371430;59156.70421647864;59516;59624;59713.40286597165;59849;1355.755963926483;1407;1470.1913947328926;1506.1113942773598;1552.8990615609948;27961.44077118487;28110.85944570264;28598.857005715672;28665.996690115746;28893.855530722212;43733.34399983939;43937.56062439334;43998;44125;50253.24620130774;235232;451093;461479;462095;464210.78946051886;34127.65872341344;34198.65801342054;34443.65556344505;34472.82763586166;34506.82746586251;47194.76402617965;48417.03165936732;48507;49629;53416.732916336725;37976.430353544165;38011.42982855315;38504.614953851225;39087.41368879412;39694;35830.78012007911;36479;36842.8157859209;38807.805960970014;40099;38494.80752596219;38528.2294354117;39418.802905985285;39461.80269098636;39537.60462395339;33483;34978.825105874304;35006.82496587501;35417.468737969466;35698.82150589334;26799.598006029537;26800.463990719687;26975.32561685895;27088;27156.185314440598 20:19:47 INFO - PROCESS | 9791 | |2;jquery.html;384.40801166204045;384.94610754494374;386.9168128852297;388.5900375104264;391.7394932369974;14796.526562024606;14875.404983800636;16875.32498700052;18547.16537755799;18556.62886742264;17531.91234043828;17677.204525796336;17715.202815873283;18777.718334225;18822.905885470554;5882.88234235315;6125.203723515937;6126.7549298028025;6147.47746441553;6153.353897840707;4463.553644635526;4616.6537509686905;6006.069059295816;6487.351264873522;6645.568038077534;6616.669166541677;6732.697028633699;6810;6838.760643377483;6850.794476165723;6487.448566871822;6662.467002639825;6669.299723529008;6676.2989886062;6714.227863795677;6449.774257900998;6461.741530338828;6463.095166676669;6470.6117632941705;6474.223093228796;21538;21906.89046554773;22663.433414164614;22692.319230423112;22723.772762272332;2221.7889300516426;2288.8855557222237;2314.6065168921323;2338.6024375856146;2341.1922886604093;13967.720645587133;14138.50515231962;14274.714505709931;14342;14695.11829290246;1846.5660569766228;1928.6914093744933;1957.8335841453493;2028.2698228637678;2051.302557130568;53879.19181212285;54979.175312370746;62744.37255627431;65076;66693;10562.471876406149;10820.4048777318;10855.565777368975;10925.344479331265;10975.725606859733;14329.211893345966;14388.424463021362;14400.855991440161;14453.421863125357;14558.781618275734;7854.332381747501;7886.250806173404;7905.920940790634;8074.596270186467;8087.716929907425;7653;7889.250521200477;7903.209679032051;7909.1695371985115;7955.323797477164;4328.220920234388;4476.574725401082;4785.066911952205;4860.756962151878;4918.704877707278;1905.3712274949235;1941.5922656242346;1958.3831093205595;1974.3484650065443;1975.2987689370354;969.4280374579032;974.4786539201493;978.6476868327396;1049.5329578337567;1077.7305673581604;14055.859441405659;16256.431024914307;16593.91703041477;16921.7461738074;17793.021383823754;939.4785893828854;995.581855620641;1001.7495626093477;1011.691434112588;1015.6749840051112;9476;9680.515974201262;9749.463779492055;9750.707478775648;9814.705558833246;560342;560717;563340;567388;576026;76488;76900;78966;79254.41491170145;80508.59745701351;1218.031664826465;1226.6810629236284;1231.119749379198;1240.522398876421;1243.589615426889;14604.561863144123;14802.475724039508;14991.700165996837;14999.12510936133;15025.248737563297;35615.50691451573;35993.28013439769;36011.63988360083;36112.277754444236;37033.62966370302;43975.78012109919;44689.77655111704;45944.08111837678;46114.538854611026;46877;7615.314621684075;7781.988341515566;7800.570968596781;7803.609819509115;7811.140774514685;11539.538418463168;11770.823437648613;11811.527538898692;12009.159358844798;12193.939030304791;9798.51007449639;10240.795184096127;10391.53238104272;10425.061744442733;10531.104856087319;7531.8117047074265;9775.657851975147;10102;10344.224183186441;10472.31929924583;9871.457069861226;10243.897561024593;10597.41714205726;10611.628592999208;10761.085307748928;7288.453365997678;7470.551766894004;7488.513246638951;7615.847683046419;7676.424268179797;9304.813903721752;10003.649872254437;10270.383776973405;10298.3820970742;10712.73218169552 20:19:47 INFO - PROCESS | 9791 | |3;mootools.html;1347.6091933339333;1500.5948393933638;1515.4392874636387;1732.722764357703;1890.0644181130333;6946;7570.697172113116;7723.382129429653;7738.613069346538;7756.92243077569;7669.041369828771;7722.420818438612;7792.805179870506;7798.0642322921185;7802.570858602775;2316.721993360799;2337.9415514612188;2339.6256598944174;2342.917997870075;2343.53129374125;2296.701428814252;2316.6061769499224;2368.52629474105;2373.52529494101;2384.1178763857397;2353.211674089174;2372.5610762008996;2373;2377.072941552796;2383.4994651123284;2342.8711420871846;2361.327021798788;2364.255259593231;2368.301351101429;2381.9285421437385;2300.7584203658544;2305.8616483011074;2311.5376924615143;2313.340697901107;2315.166540045582;8017.759467215993;8061.435699501038;8064.435489515737;8065.354771618257;8068.072171700271;4534.455865296186;4652.302154676826;4738.241881298975;4754.809807607691;4778.354922085508;3004.549317602355;3010.68387819278;3040.9847950760327;3066.8466576671076;3081.984590077035;1035.585765693721;1046.9479819553685;1051.363924825485;1064.6805958212583;1066.8399740039056;10785.514651840607;10789.83815242772;10791.622293219778;10795;10806.02745752886;4023.8591649292134;4030.879073627796;4083.1017176221185;4107.281225785536;4108.198901214294;9260.351775375659;9277;9284.814303714023;9286.164245217962;9290.210332121711;4757.119932812441;4757.762111894392;4768.427788665383;4769.093872164278;4769.642276829251;3969.186316805048;4088.8160032798596;4290.2063118322585;4326.372675961968;4384.714993525411;3741.7006639468777;3760.172761992357;3779.5842457329672;3802;3834.4631751554803;1218.4273391505978;1224.0452447091104;1228.6621179175797;1231;1239.962801115968;1437.0802686280788;1437.6477762947936;1439.0574173916102;1459.073488334915;1460.488828909873;7478.252174782587;7479.439042071866;7482.625868706543;7521.887171692429;7538.698452061966;525.3606351287237;531.7208465555615;533.2214966149388;533.7704786941574;536.0164098878602;5830.883382332415;5914.970425147847;5915.58590898633;5922.170896074553;5927.673977931169;9154.176124148726;9259.953700231456;9409.905900940903;9433.056694330511;9452.8582071269;9108.59011344491;9261.398009129385;9278.257739380833;9280.118388753057;9292.256619470427;7238.167610724729;7424;7430.479866409408;7496.437767167485;7507.436942229246;7354.48518603714;7425.9628701856145;7430.219826918095;7437;7471.21552237029;8282.83434331298;8499.617517211616;8569;8616.396852220536;8645.178708022728;8549.743507694779;8594.484330940164;8635.179657932485;8679.132086791271;8734.170253825876;6459.386358295955;6559.048937903882;6853.691583878638;6965.686544105629;7048.471364647569;7532.698692052257;7536.547807131589;7586.468947173645;7590.582517961565;7596.468247222641;6885;7030.578165310098;7068.187158476841;7195.496315257882;7271.672774725044;7093.680784364819;7115.359617634438;7139.643017849191;7191.244919283609;7210.242924492853;7082.220955694973;7136.250693677297;7294.416446684147;7296.525725827804;7299.744508942162;6589.505787066085;6599.109120268894;6600.735970561123;6620.702068407029;6621.172353455818;6703.865922681422;6744.190697116182;6791.2190098139345;6808.5914845109455;6819.318068193141 20:19:47 INFO - PROCESS | 9791 | |4;prototype.html;341.96067452242994;346.5564077980186;349.1376300537673;356.8412056634795;360.9981950090251;5960.64236145831;5985.521158307336;5988.341282458926;6002.009668404708;6007.339192688801;5696.601237913348;5782.942170578293;5814.796482123126;5883.88232235355;5917.28992520897;4612.97693511532;4664.7434391108645;4677.90069333708;4678.391809064817;4678.6023188028885;4487.5736805003635;4677.88305292367;4679.976600117012;4682.484926658065;4702.083093796711;4499.46006479223;4542.909141817162;4565.292379681155;4577.633789296865;4584.931226031612;4538.228501154812;4577.473590537097;4587.921838367997;4591.471980722226;4599.793009314589;4079.000644842003;4080.0615858352744;4085.8151136170477;4088.7342322749223;4097.221527909717;5540.252065971123;5661.971690141564;5665.5467562594895;5672.120821272668;5672.716364181816;5331.600129990266;5347.973260133714;5349.946500534984;5364.088105022156;5369.919451208235;6279.34066922971;6286.9056964145575;6289.119523266746;6293.874122517524;6325.051242313643;4504;4509.932351014738;4511.233090374644;4511.819527218908;4514.932276015862;6459.160309159826;6525.804225873231;6540.542162048659;6588.439982601484;6594.571352862049;4530.886727831765;4532.682712210114;4538.183127037165;4538.863834084983;4540.182767101887;4584.15193189261;4589.862304130881;4591.219492686251;4592.88517787058;4593.63250939924;5268.525832675077;5270.1040823060175;5278.366596008504;5280.656757310762;5287.576993840484;6217.96891015542;6310.305866354697;6315.494760419156;6328.873422531524;6339.492840572743;1613.2498388249521;1624.6994306053418;1626.8698504119643;1627.5117464760524;1629.0470075006017;1092.4592326798127;1093.781243751237;1096.7313008312856;1097.8627671541058;1098.3958822647671;6151.630902145886;6153.661548614779;6156.569040167145;6156.6921653917125;6160.353162917919;6342.365763423713;6533.967330163414;6538.346165383518;6545.5090868184125;6550.475961923034;6037.305709843336;6044.032954727222;6141.907871381933;6144.969275153596;6147.815565533041;3466.6706662866986;3535.222251104753;3536.8938931832085;3537.7877327359924;3541.026217790128;6632.767853125118;6757.391834734897;6763.458923286125;6772.966135169293;6776.830579235559;6733;6736.629485378351;6743.966280168568;6747.392734653807;6748.966255168692;6760.661966901635;6762.391384775394;6769.661516924134;6769.8646027079185;6777.49168812341;6420;6553.934460655332;6566.507511936719;6571.57284776488;6585.20977482686;6457.225132984072;6462.3537646235;6462.386073323027;6470.352964703492;6472;6752.831179220559;6754.459643228628;6758.966205168943;6764.695588698619;6780.559263647847;4556.33933079695;4561.771911404483;4562.270036794097;4562.315652652129;4566.429196350457;6416.13382193398;6580.539362244788;6583.144191255297;6587;6593.835154121185;6419.45434638061;6423.325550817097;6426;6426.678666066771;6427.453666438218;6317.936820631735;6401.327860574573;6402.90395644075;6404.1674582304;6413.679316034087;6347.968260158855;6381.680915954276;6382.0745991831855;6386.872262554816;6390.329015453311;6425.550211485338;6431.324710905475;6444.162258906312;6445.16212892321;6453;6124.816255512342;6239.344868788712;6240.063990401476;6246.281677606951;6252.468540174136 20:19:47 INFO - PROCESS | 9791 | |5;yui.html;918.4581097152675;925.5603588295556;941.5857022909919;946.2430055955236;958.519088009026;14609.196494192814;14719.852801471981;14726;14733.484328048507;14771.926140369296;13337;13820.308984550782;13901.096428732126;13967.860321396784;13995.93002034991;675.0886303490273;691.3190507350256;692.0726226856012;886.9600867960941;911.1890417528405;697.7174244431013;874.567089290802;904.0913881549034;905.710172744722;906.2976193450063;942.8585712143165;949.838527450335;950.6007476859736;952.8237276103943;953.4708236928502;782.8434313137395;806.1454857850639;943.9103285187896;945.9290553208502;946.0633972367375;684.5687217053274;697.1564407067455;703.0087576517086;704.1057856522189;704.5068452083563;14452.783208251885;14497.855021449755;14502.41990320386;14524.70950580993;14556.0538564994;13315.467381304736;13804.516841910485;13929.512467063705;14126.01117921746;14205.715885682228;11120.666380008532;11125.777484450266;11214.775704485946;11226.663200103929;11272.323660580392;3842.711796615265;3879.4180872869015;3898.922021559553;3936.960630393688;3940.8817735467983;49086.7545662273;49268.26097608539;49972.25041624415;50195;50485.495145048444;10337.276390652733;10421.426821524738;10699.411532365795;10835.349879007284;10910.181736369805;19042.33351832679;19512.414627560913;19540.022998850283;19557.119929603203;19569.8043019568;8064.637091330904;8097.433179677366;8119.512829230265;8176.754697359089;8268.421210515206;4185.100203456272;4270.572942705767;4496.842610508616;4624.606908412756;4679.134360143385;3244.5944256967878;3257.250832308582;3275.082976766509;3294.8682052718104;3304.0583433721754;566.9404712505127;570.5264630356794;572.9197912292283;586.6040422714735;594.4917095883044;546.519063224368;628.955973081889;632.339205530222;641.470786601056;756.0247281007439;9294.163525282622;9328.39365441244;9338.299627527962;9443.858342124873;9478.478683672463;640.4108220437209;641.1760887259849;712.9394001509826;734.0970606154353;791.7347688524409;4329.826806927751;4375.212461756851;4393.956060439418;4547.090581883636;4577.931331030038;58080.70959645175;58260.70869645625;58292.4170758287;58396;58463.415365846646;52039.479605203465;53928.730356347965;54314;54364;54851.72574137104;46612.3008154878;48186.759066204446;48940.265896010875;49422.25866612004;50187.24719129216;9043.63825447001;9212.355135140477;9227.261819054595;9264.212541934012;9279.211267042378;35565.46651800173;35806.46290305595;36029.27941441209;36468;36966.815165923996;44436.33345499885;47706;47850;48296;48422.75788621034;11840.940795295968;11934.820977685167;11959.103067269816;12367.319797411228;12471.249170528983;11815.527378904748;12976.286304253357;13025.544105956626;13349.532766353132;13502.257375844423;12442.191257568229;12591.559295424617;12599;12689.87310126887;13249.668758280735;12236.265824050586;12501.93749031249;12635.431405586954;12936.417861196456;13199.340032998503;11435.142364322875;11527.481263343001;11786.941065294619;11870.584529541424;12658.11393202467;10197.643082492077;10251.077403033763;10620.84068738985;10702.571897124028;10787.67636970892;10239.18086553059;10615.522301496298;10641.414722190353;10664.89335106639;10677.679669609925 20:19:47 INFO - PROCESS | 9791 | __end_tp_report 20:19:47 INFO - PROCESS | 9791 | __start_cc_report 20:19:47 INFO - PROCESS | 9791 | _x_x_mozilla_cycle_collect,778 20:19:47 INFO - PROCESS | 9791 | __end_cc_report 20:19:47 INFO - PROCESS | 9791 | __startTimestamp1459480787868__endTimestamp 20:19:47 INFO - PROCESS | 9791 | 20:19:47 INFO - PROCESS | 9791 | ------- Summary: start ------- 20:19:47 INFO - PROCESS | 9791 | Number of tests: 6 20:19:47 INFO - PROCESS | 9791 | 20:19:47 INFO - PROCESS | 9791 | [#0] dojo.html Cycles:165 Average:5114.58 Median:5306.23 stddev:520.22 (9.8%) stddev-sans-first:499.42 20:19:47 INFO - PROCESS | 9791 | Values: 3189.7 3236.9 3261.0 3263.4 3298.9 5138.0 5144.5 5161.1 5169.6 5193.2 5156.1 5162.4 5186.4 5195.2 5214.8 4600.5 4705.6 4733.9 4767.9 4832.9 4701.7 4705.6 4736.2 4739.6 4746.6 4664.3 4666.3 4701.3 4741.1 4753.0 4764.5 4798.3 4800.5 4802.4 4804.4 4719.5 4734.0 4750.5 4774.6 4804.8 4915.9 4936.0 4987.2 5000.8 5003.8 5507.3 5515.4 5521.7 5525.6 5530.6 5382.7 5497.8 5508.8 5540.0 5562.2 5163.4 5163.5 5216.7 5221.6 5222.7 5570.4 5600.3 5600.6 5604.5 5623.3 5322.5 5387.8 5393.0 5397.3 5398.2 5446.3 5479.1 5490.4 5495.6 5526.8 5454.1 5473.7 5474.2 5476.2 5479.8 5288.1 5383.2 5456.0 5477.0 5512.9 4200.4 4243.8 4247.4 4250.7 4254.7 3837.5 3851.9 3859.6 3894.8 3917.6 5179.5 5200.9 5212.1 5224.2 5239.2 5506.1 5508.9 5510.8 5512.3 5512.7 5092.1 5148.6 5163.8 5203.2 5219.4 4717.4 4735.0 4745.2 4752.7 4777.5 5499.8 5554.7 5596.4 5605.4 5615.0 5441.9 5452.3 5493.5 5508.4 5539.2 5490.7 5499.5 5512.0 5512.5 5513.5 5314.8 5330.5 5338.9 5357.8 5431.3 5518.7 5569.2 5569.9 5572.7 5590.0 5284.9 5330.8 5333.1 5336.4 5372.7 5271.3 5273.6 5326.3 5336.9 5357.9 5320.8 5339.1 5341.7 5344.3 5344.6 5413.8 5419.7 5428.1 5456.3 5459.5 5153.6 5259.5 5300.2 5306.2 5388.7 20:19:47 INFO - PROCESS | 9791 | 20:19:47 INFO - PROCESS | 9791 | [#1] ext.html Cycles:180 Average:53786.51 Median:39499.70 stddev:96876.76 (245.3%) stddev-sans-first:97066.07 20:19:47 INFO - PROCESS | 9791 | Values: 552.7 574.1 578.2 604.5 606.3 40589.8 40891.8 40932.2 40964.8 40990.0 44303.6 44992.6 45095.0 45102.8 45175.8 8773.6 9124.5 9125.3 9134.6 9149.1 8909.2 9074.5 9086.0 9103.1 9124.9 9082.5 9146.3 9180.0 9199.2 9202.8 9040.2 9187.1 9197.6 9201.9 9205.2 9027.6 9149.4 9167.5 9169.5 9173.2 44274.3 44743.6 44777.0 44812.8 44832.8 3502.6 3610.9 3937.2 4072.8 4218.3 33757.7 34382.5 34544.7 34555.5 34582.7 3901.2 4021.2 4042.1 4071.2 4078.7 296581.0 297904.0 298657.0 298961.0 298978.0 62497.0 63903.0 69307.0 70366.4 70605.6 61722.4 61869.7 61971.0 62095.4 62118.1 17114.3 17338.7 17366.6 17374.7 17379.8 12817.1 12947.5 12962.7 13045.2 13085.1 22226.2 22344.9 22377.3 22381.9 22538.0 7770.5 8486.6 8560.7 8600.4 8609.6 991.3 1002.4 1097.3 1110.7 1155.7 30878.2 30917.5 31144.2 31848.0 31922.4 1079.8 1147.2 1158.9 1167.3 1218.9 14141.8 14954.8 14965.9 15414.3 15793.8 364760.0 370021.0 370923.0 371223.0 371430.0 59156.7 59516.0 59624.0 59713.4 59849.0 1355.8 1407.0 1470.2 1506.1 1552.9 27961.4 28110.9 28598.9 28666.0 28893.9 43733.3 43937.6 43998.0 44125.0 50253.2 235232.0 451093.0 461479.0 462095.0 464210.8 34127.7 34198.7 34443.7 34472.8 34506.8 47194.8 48417.0 48507.0 49629.0 53416.7 37976.4 38011.4 38504.6 39087.4 39694.0 35830.8 36479.0 36842.8 38807.8 40099.0 38494.8 38528.2 39418.8 39461.8 39537.6 33483.0 34978.8 35006.8 35417.5 35698.8 26799.6 26800.5 26975.3 27088.0 27156.2 20:19:47 INFO - PROCESS | 9791 | 20:19:47 INFO - PROCESS | 9791 | [#2] jquery.html Cycles:180 Average:29262.46 Median:384.68 stddev:92386.99 (24016.8%) stddev-sans-first:92620.71 20:19:47 INFO - PROCESS | 9791 | Values: 384.4 384.9 386.9 388.6 391.7 14796.5 14875.4 16875.3 18547.2 18556.6 17531.9 17677.2 17715.2 18777.7 18822.9 5882.9 6125.2 6126.8 6147.5 6153.4 4463.6 4616.7 6006.1 6487.4 6645.6 6616.7 6732.7 6810.0 6838.8 6850.8 6487.4 6662.5 6669.3 6676.3 6714.2 6449.8 6461.7 6463.1 6470.6 6474.2 21538.0 21906.9 22663.4 22692.3 22723.8 2221.8 2288.9 2314.6 2338.6 2341.2 13967.7 14138.5 14274.7 14342.0 14695.1 1846.6 1928.7 1957.8 2028.3 2051.3 53879.2 54979.2 62744.4 65076.0 66693.0 10562.5 10820.4 10855.6 10925.3 10975.7 14329.2 14388.4 14400.9 14453.4 14558.8 7854.3 7886.3 7905.9 8074.6 8087.7 7653.0 7889.3 7903.2 7909.2 7955.3 4328.2 4476.6 4785.1 4860.8 4918.7 1905.4 1941.6 1958.4 1974.3 1975.3 969.4 974.5 978.6 1049.5 1077.7 14055.9 16256.4 16593.9 16921.7 17793.0 939.5 995.6 1001.7 1011.7 1015.7 9476.0 9680.5 9749.5 9750.7 9814.7 560342.0 560717.0 563340.0 567388.0 576026.0 76488.0 76900.0 78966.0 79254.4 80508.6 1218.0 1226.7 1231.1 1240.5 1243.6 14604.6 14802.5 14991.7 14999.1 15025.2 35615.5 35993.3 36011.6 36112.3 37033.6 43975.8 44689.8 45944.1 46114.5 46877.0 7615.3 7782.0 7800.6 7803.6 7811.1 11539.5 11770.8 11811.5 12009.2 12193.9 9798.5 10240.8 10391.5 10425.1 10531.1 7531.8 9775.7 10102.0 10344.2 10472.3 9871.5 10243.9 10597.4 10611.6 10761.1 7288.5 7470.6 7488.5 7615.8 7676.4 9304.8 10003.6 10270.4 10298.4 10712.7 20:19:47 INFO - PROCESS | 9791 | 20:19:47 INFO - PROCESS | 9791 | [#3] mootools.html Cycles:180 Average:5521.19 Median:6509.22 stddev:2859.37 (43.9%) stddev-sans-first:2850.18 20:19:47 INFO - PROCESS | 9791 | Values: 1347.6 1500.6 1515.4 1732.7 1890.1 6946.0 7570.7 7723.4 7738.6 7756.9 7669.0 7722.4 7792.8 7798.1 7802.6 2316.7 2337.9 2339.6 2342.9 2343.5 2296.7 2316.6 2368.5 2373.5 2384.1 2353.2 2372.6 2373.0 2377.1 2383.5 2342.9 2361.3 2364.3 2368.3 2381.9 2300.8 2305.9 2311.5 2313.3 2315.2 8017.8 8061.4 8064.4 8065.4 8068.1 4534.5 4652.3 4738.2 4754.8 4778.4 3004.5 3010.7 3041.0 3066.8 3082.0 1035.6 1046.9 1051.4 1064.7 1066.8 10785.5 10789.8 10791.6 10795.0 10806.0 4023.9 4030.9 4083.1 4107.3 4108.2 9260.4 9277.0 9284.8 9286.2 9290.2 4757.1 4757.8 4768.4 4769.1 4769.6 3969.2 4088.8 4290.2 4326.4 4384.7 3741.7 3760.2 3779.6 3802.0 3834.5 1218.4 1224.0 1228.7 1231.0 1240.0 1437.1 1437.6 1439.1 1459.1 1460.5 7478.3 7479.4 7482.6 7521.9 7538.7 525.4 531.7 533.2 533.8 536.0 5830.9 5915.0 5915.6 5922.2 5927.7 9154.2 9260.0 9409.9 9433.1 9452.9 9108.6 9261.4 9278.3 9280.1 9292.3 7238.2 7424.0 7430.5 7496.4 7507.4 7354.5 7426.0 7430.2 7437.0 7471.2 8282.8 8499.6 8569.0 8616.4 8645.2 8549.7 8594.5 8635.2 8679.1 8734.2 6459.4 6559.0 6853.7 6965.7 7048.5 7532.7 7536.5 7586.5 7590.6 7596.5 6885.0 7030.6 7068.2 7195.5 7271.7 7093.7 7115.4 7139.6 7191.2 7210.2 7082.2 7136.3 7294.4 7296.5 7299.7 6589.5 6599.1 6600.7 6620.7 6621.2 6703.9 6744.2 6791.2 6808.6 6819.3 20:19:47 INFO - PROCESS | 9791 | 20:19:47 INFO - PROCESS | 9791 | [#4] prototype.html Cycles:180 Average:5325.60 Median:6040.67 stddev:1588.95 (26.3%) stddev-sans-first:1548.75 20:19:47 INFO - PROCESS | 9791 | Values: 342.0 346.6 349.1 356.8 361.0 5960.6 5985.5 5988.3 6002.0 6007.3 5696.6 5782.9 5814.8 5883.9 5917.3 4613.0 4664.7 4677.9 4678.4 4678.6 4487.6 4677.9 4680.0 4682.5 4702.1 4499.5 4542.9 4565.3 4577.6 4584.9 4538.2 4577.5 4587.9 4591.5 4599.8 4079.0 4080.1 4085.8 4088.7 4097.2 5540.3 5662.0 5665.5 5672.1 5672.7 5331.6 5348.0 5349.9 5364.1 5369.9 6279.3 6286.9 6289.1 6293.9 6325.1 4504.0 4509.9 4511.2 4511.8 4514.9 6459.2 6525.8 6540.5 6588.4 6594.6 4530.9 4532.7 4538.2 4538.9 4540.2 4584.2 4589.9 4591.2 4592.9 4593.6 5268.5 5270.1 5278.4 5280.7 5287.6 6218.0 6310.3 6315.5 6328.9 6339.5 1613.2 1624.7 1626.9 1627.5 1629.0 1092.5 1093.8 1096.7 1097.9 1098.4 6151.6 6153.7 6156.6 6156.7 6160.4 6342.4 6534.0 6538.3 6545.5 6550.5 6037.3 6044.0 6141.9 6145.0 6147.8 3466.7 3535.2 3536.9 3537.8 3541.0 6632.8 6757.4 6763.5 6773.0 6776.8 6733.0 6736.6 6744.0 6747.4 6749.0 6760.7 6762.4 6769.7 6769.9 6777.5 6420.0 6553.9 6566.5 6571.6 6585.2 6457.2 6462.4 6462.4 6470.4 6472.0 6752.8 6754.5 6759.0 6764.7 6780.6 4556.3 4561.8 4562.3 4562.3 4566.4 6416.1 6580.5 6583.1 6587.0 6593.8 6419.5 6423.3 6426.0 6426.7 6427.5 6317.9 6401.3 6402.9 6404.2 6413.7 6348.0 6381.7 6382.1 6386.9 6390.3 6425.6 6431.3 6444.2 6445.2 6453.0 6124.8 6239.3 6240.1 6246.3 6252.5 20:19:47 INFO - PROCESS | 9791 | 20:19:47 INFO - PROCESS | 9791 | [#5] yui.html Cycles:180 Average:14599.40 Median:24466.59 stddev:16521.49 (67.5%) stddev-sans-first:16535.90 20:19:47 INFO - PROCESS | 9791 | Values: 918.5 925.6 941.6 946.2 958.5 14609.2 14719.9 14726.0 14733.5 14771.9 13337.0 13820.3 13901.1 13967.9 13995.9 675.1 691.3 692.1 887.0 911.2 697.7 874.6 904.1 905.7 906.3 942.9 949.8 950.6 952.8 953.5 782.8 806.1 943.9 945.9 946.1 684.6 697.2 703.0 704.1 704.5 14452.8 14497.9 14502.4 14524.7 14556.1 13315.5 13804.5 13929.5 14126.0 14205.7 11120.7 11125.8 11214.8 11226.7 11272.3 3842.7 3879.4 3898.9 3937.0 3940.9 49086.8 49268.3 49972.3 50195.0 50485.5 10337.3 10421.4 10699.4 10835.3 10910.2 19042.3 19512.4 19540.0 19557.1 19569.8 8064.6 8097.4 8119.5 8176.8 8268.4 4185.1 4270.6 4496.8 4624.6 4679.1 3244.6 3257.3 3275.1 3294.9 3304.1 566.9 570.5 572.9 586.6 594.5 546.5 629.0 632.3 641.5 756.0 9294.2 9328.4 9338.3 9443.9 9478.5 640.4 641.2 712.9 734.1 791.7 4329.8 4375.2 4394.0 4547.1 4577.9 58080.7 58260.7 58292.4 58396.0 58463.4 52039.5 53928.7 54314.0 54364.0 54851.7 46612.3 48186.8 48940.3 49422.3 50187.2 9043.6 9212.4 9227.3 9264.2 9279.2 35565.5 35806.5 36029.3 36468.0 36966.8 44436.3 47706.0 47850.0 48296.0 48422.8 11840.9 11934.8 11959.1 12367.3 12471.2 11815.5 12976.3 13025.5 13349.5 13502.3 12442.2 12591.6 12599.0 12689.9 13249.7 12236.3 12501.9 12635.4 12936.4 13199.3 11435.1 11527.5 11786.9 11870.6 12658.1 10197.6 10251.1 10620.8 10702.6 10787.7 10239.2 10615.5 10641.4 10664.9 10677.7 20:19:47 INFO - PROCESS | 9791 | -------- Summary: end -------- 20:19:47 INFO - PROCESS | 9791 | 20:19:48 INFO - TEST-INFO | 9791: exit 0 20:19:48 INFO - TEST-OK | dromaeo_css | took 1110363ms 20:19:48 INFO - TEST-START | kraken 20:19:48 INFO - operating with platform_type : linux_ 20:19:48 INFO - Initialising browser for kraken test... 20:19:48 INFO - TEST-INFO | started process 9990 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYwSF9T/profile http://localhost:48630/getInfo.html) 20:19:52 INFO - PROCESS | 9990 | __metrics Screen width/height:1600/1200 20:19:52 INFO - PROCESS | 9990 | colorDepth:24 20:19:52 INFO - PROCESS | 9990 | Browser inner width/height: 1024/697 20:19:52 INFO - PROCESS | 9990 | __metrics 20:19:52 INFO - PROCESS | 9990 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:19:53 INFO - TEST-INFO | 9990: exit 0 20:19:53 INFO - Browser initialized. 20:19:53 INFO - Running cycle 1/1 for kraken test... 20:19:53 INFO - TEST-INFO | started process 10083 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYwSF9T/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:20:05 INFO - PROCESS | 10083 | RSS: Main: 137621504 20:20:05 INFO - PROCESS | 10083 | 20:20:08 INFO - PROCESS | 10083 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48630/tests/kraken/driver.html?testName=audio-beat-detection) 20:20:08 INFO - PROCESS | 10083 | RSS: Main: 171032576 20:20:08 INFO - PROCESS | 10083 | 20:20:11 INFO - PROCESS | 10083 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48630/tests/kraken/driver.html?testName=audio-dft) 20:20:11 INFO - PROCESS | 10083 | RSS: Main: 169672704 20:20:11 INFO - PROCESS | 10083 | 20:20:14 INFO - PROCESS | 10083 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48630/tests/kraken/driver.html?testName=audio-fft) 20:20:15 INFO - PROCESS | 10083 | RSS: Main: 166940672 20:20:15 INFO - PROCESS | 10083 | 20:20:17 INFO - PROCESS | 10083 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48630/tests/kraken/driver.html?testName=audio-oscillator) 20:20:17 INFO - PROCESS | 10083 | RSS: Main: 167542784 20:20:17 INFO - PROCESS | 10083 | 20:20:20 INFO - PROCESS | 10083 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48630/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:20:20 INFO - PROCESS | 10083 | RSS: Main: 164564992 20:20:20 INFO - PROCESS | 10083 | 20:20:23 INFO - PROCESS | 10083 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48630/tests/kraken/driver.html?testName=imaging-darkroom) 20:20:24 INFO - PROCESS | 10083 | RSS: Main: 165371904 20:20:24 INFO - PROCESS | 10083 | 20:20:27 INFO - PROCESS | 10083 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48630/tests/kraken/driver.html?testName=imaging-desaturate) 20:20:27 INFO - PROCESS | 10083 | RSS: Main: 165257216 20:20:27 INFO - PROCESS | 10083 | 20:20:30 INFO - PROCESS | 10083 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48630/tests/kraken/driver.html?testName=json-parse-financial) 20:20:31 INFO - PROCESS | 10083 | RSS: Main: 164556800 20:20:31 INFO - PROCESS | 10083 | 20:20:32 INFO - PROCESS | 10083 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48630/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:20:33 INFO - PROCESS | 10083 | RSS: Main: 169816064 20:20:33 INFO - PROCESS | 10083 | 20:20:35 INFO - PROCESS | 10083 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48630/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:20:35 INFO - PROCESS | 10083 | RSS: Main: 168206336 20:20:35 INFO - PROCESS | 10083 | 20:20:37 INFO - PROCESS | 10083 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48630/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:20:38 INFO - PROCESS | 10083 | RSS: Main: 173985792 20:20:38 INFO - PROCESS | 10083 | 20:20:40 INFO - PROCESS | 10083 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:20:41 INFO - PROCESS | 10083 | RSS: Main: 177872896 20:20:41 INFO - PROCESS | 10083 | 20:20:43 INFO - PROCESS | 10083 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:20:44 INFO - PROCESS | 10083 | RSS: Main: 175431680 20:20:44 INFO - PROCESS | 10083 | 20:20:45 INFO - PROCESS | 10083 | Cycle 1(1): loaded http://localhost:48630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48630/tests/kraken/driver.html?testName=ai-astar) 20:20:45 INFO - PROCESS | 10083 | RSS: Main: 236879872 20:20:45 INFO - PROCESS | 10083 | 20:20:45 INFO - PROCESS | 10083 | __start_tp_report 20:20:45 INFO - PROCESS | 10083 | _x_x_mozilla_page_load 20:20:45 INFO - PROCESS | 10083 | _x_x_mozilla_page_load_details 20:20:45 INFO - PROCESS | 10083 | |i|pagename|runs| 20:20:45 INFO - PROCESS | 10083 | |0;ai-astar;110;112;107;110;110;110;100;111;109;109 20:20:45 INFO - PROCESS | 10083 | |1;audio-beat-detection;149;125;148;168;125;151;152;126;162;125 20:20:45 INFO - PROCESS | 10083 | |2;audio-dft;160;162;159;161;160;158;160;161;162;159 20:20:45 INFO - PROCESS | 10083 | |3;audio-fft;72;76;73;157;75;73;75;76;145;75 20:20:45 INFO - PROCESS | 10083 | |4;audio-oscillator;96;96;150;96;95;96;138;96;97;141 20:20:45 INFO - PROCESS | 10083 | |5;imaging-gaussian-blur;109;109;109;109;109;110;109;109;108;110 20:20:45 INFO - PROCESS | 10083 | |6;imaging-darkroom;146;145;145;145;146;146;146;146;146;145 20:20:45 INFO - PROCESS | 10083 | |7;imaging-desaturate;96;95;96;96;96;95;96;96;96;96 20:20:45 INFO - PROCESS | 10083 | |8;json-parse-financial;54;61;54;54;54;55;55;54;53;55 20:20:45 INFO - PROCESS | 10083 | |9;json-stringify-tinderbox;63;65;64;64;64;63;65;64;63;64 20:20:45 INFO - PROCESS | 10083 | |10;stanford-crypto-aes;77;76;79;77;78;76;77;77;80;78 20:20:45 INFO - PROCESS | 10083 | |11;stanford-crypto-ccm;110;110;109;113;111;117;113;109;108;118 20:20:45 INFO - PROCESS | 10083 | |12;stanford-crypto-pbkdf2;135;134;133;133;134;132;134;131;131;132 20:20:45 INFO - PROCESS | 10083 | |13;stanford-crypto-sha256-iterative;68;65;65;65;65;65;66;63;64;64 20:20:45 INFO - PROCESS | 10083 | __end_tp_report 20:20:45 INFO - PROCESS | 10083 | __start_cc_report 20:20:45 INFO - PROCESS | 10083 | _x_x_mozilla_cycle_collect,896 20:20:45 INFO - PROCESS | 10083 | __end_cc_report 20:20:45 INFO - PROCESS | 10083 | __startTimestamp1459480845936__endTimestamp 20:20:45 INFO - PROCESS | 10083 | 20:20:45 INFO - PROCESS | 10083 | ------- Summary: start ------- 20:20:45 INFO - PROCESS | 10083 | Number of tests: 14 20:20:45 INFO - PROCESS | 10083 | 20:20:45 INFO - PROCESS | 10083 | [#0] ai-astar Cycles:10 Average:108.80 Median:110.00 stddev:3.36 (3.1%) stddev-sans-first:3.54 20:20:45 INFO - PROCESS | 10083 | Values: 110.0 112.0 107.0 110.0 110.0 110.0 100.0 111.0 109.0 109.0 20:20:45 INFO - PROCESS | 10083 | 20:20:45 INFO - PROCESS | 10083 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:150.00 stddev:16.51 (11.0%) stddev-sans-first:17.37 20:20:45 INFO - PROCESS | 10083 | Values: 149.0 125.0 148.0 168.0 125.0 151.0 152.0 126.0 162.0 125.0 20:20:45 INFO - PROCESS | 10083 | 20:20:45 INFO - PROCESS | 10083 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:1.32 (0.8%) stddev-sans-first:1.39 20:20:45 INFO - PROCESS | 10083 | Values: 160.0 162.0 159.0 161.0 160.0 158.0 160.0 161.0 162.0 159.0 20:20:45 INFO - PROCESS | 10083 | 20:20:45 INFO - PROCESS | 10083 | [#3] audio-fft Cycles:10 Average:89.70 Median:75.00 stddev:32.46 (43.3%) stddev-sans-first:33.79 20:20:45 INFO - PROCESS | 10083 | Values: 72.0 76.0 73.0 157.0 75.0 73.0 75.0 76.0 145.0 75.0 20:20:45 INFO - PROCESS | 10083 | 20:20:45 INFO - PROCESS | 10083 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:96.00 stddev:22.90 (23.9%) stddev-sans-first:23.71 20:20:45 INFO - PROCESS | 10083 | Values: 96.0 96.0 150.0 96.0 95.0 96.0 138.0 96.0 97.0 141.0 20:20:45 INFO - PROCESS | 10083 | 20:20:45 INFO - PROCESS | 10083 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 20:20:45 INFO - PROCESS | 10083 | Values: 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 108.0 110.0 20:20:45 INFO - PROCESS | 10083 | 20:20:45 INFO - PROCESS | 10083 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:20:45 INFO - PROCESS | 10083 | Values: 146.0 145.0 145.0 145.0 146.0 146.0 146.0 146.0 146.0 145.0 20:20:45 INFO - PROCESS | 10083 | 20:20:45 INFO - PROCESS | 10083 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:20:45 INFO - PROCESS | 10083 | Values: 96.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 20:20:45 INFO - PROCESS | 10083 | 20:20:45 INFO - PROCESS | 10083 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.50 stddev:2.23 (4.1%) stddev-sans-first:2.35 20:20:45 INFO - PROCESS | 10083 | Values: 54.0 61.0 54.0 54.0 54.0 55.0 55.0 54.0 53.0 55.0 20:20:45 INFO - PROCESS | 10083 | 20:20:45 INFO - PROCESS | 10083 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 20:20:45 INFO - PROCESS | 10083 | Values: 63.0 65.0 64.0 64.0 64.0 63.0 65.0 64.0 63.0 64.0 20:20:45 INFO - PROCESS | 10083 | 20:20:45 INFO - PROCESS | 10083 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.50 stddev:1.27 (1.6%) stddev-sans-first:1.33 20:20:45 INFO - PROCESS | 10083 | Values: 77.0 76.0 79.0 77.0 78.0 76.0 77.0 77.0 80.0 78.0 20:20:45 INFO - PROCESS | 10083 | 20:20:45 INFO - PROCESS | 10083 | [#11] stanford-crypto-ccm Cycles:10 Average:111.80 Median:112.00 stddev:3.43 (3.1%) stddev-sans-first:3.57 20:20:45 INFO - PROCESS | 10083 | Values: 110.0 110.0 109.0 113.0 111.0 117.0 113.0 109.0 108.0 118.0 20:20:45 INFO - PROCESS | 10083 | 20:20:45 INFO - PROCESS | 10083 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.90 Median:133.50 stddev:1.37 (1.0%) stddev-sans-first:1.22 20:20:45 INFO - PROCESS | 10083 | Values: 135.0 134.0 133.0 133.0 134.0 132.0 134.0 131.0 131.0 132.0 20:20:45 INFO - PROCESS | 10083 | 20:20:45 INFO - PROCESS | 10083 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:1.33 (2.1%) stddev-sans-first:0.87 20:20:45 INFO - PROCESS | 10083 | Values: 68.0 65.0 65.0 65.0 65.0 65.0 66.0 63.0 64.0 64.0 20:20:45 INFO - PROCESS | 10083 | -------- Summary: end -------- 20:20:45 INFO - PROCESS | 10083 | 20:20:46 INFO - TEST-INFO | 10083: exit 0 20:20:46 INFO - TEST-OK | kraken | took 58281ms 20:20:46 INFO - TEST-START | v8_7 20:20:46 INFO - operating with platform_type : linux_ 20:20:46 INFO - Initialising browser for v8_7 test... 20:20:46 INFO - TEST-INFO | started process 10343 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu6S0Eb/profile http://localhost:48630/getInfo.html) 20:20:51 INFO - PROCESS | 10343 | __metrics Screen width/height:1600/1200 20:20:51 INFO - PROCESS | 10343 | colorDepth:24 20:20:51 INFO - PROCESS | 10343 | Browser inner width/height: 1024/697 20:20:51 INFO - PROCESS | 10343 | __metrics 20:20:51 INFO - PROCESS | 10343 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:20:51 INFO - TEST-INFO | 10343: exit 0 20:20:51 INFO - Browser initialized. 20:20:51 INFO - Running cycle 1/1 for v8_7 test... 20:20:51 INFO - TEST-INFO | started process 10435 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpu6S0Eb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:21:03 INFO - PROCESS | 10435 | RSS: Main: 136785920 20:21:03 INFO - PROCESS | 10435 | 20:21:26 INFO - PROCESS | 10435 | Cycle 1(1): loaded http://localhost:48630/tests/v8_7/run.html (next: http://localhost:48630/tests/v8_7/run.html) 20:21:26 INFO - PROCESS | 10435 | RSS: Main: 425435136 20:21:26 INFO - PROCESS | 10435 | 20:21:26 INFO - PROCESS | 10435 | __start_tp_report 20:21:26 INFO - PROCESS | 10435 | _x_x_mozilla_page_load 20:21:26 INFO - PROCESS | 10435 | _x_x_mozilla_page_load_details 20:21:26 INFO - PROCESS | 10435 | |i|pagename|runs| 20:21:26 INFO - PROCESS | 10435 | |0;Richards;167.3080140538732 20:21:26 INFO - PROCESS | 10435 | |1;DeltaBlue;169.34801016088062 20:21:26 INFO - PROCESS | 10435 | |2;Encrypt;277.9321845469705 20:21:26 INFO - PROCESS | 10435 | |3;Decrypt;5235.602094240838 20:21:26 INFO - PROCESS | 10435 | |4;RayTrace;958.7727708533077 20:21:26 INFO - PROCESS | 10435 | |5;Earley;559.9104143337066 20:21:26 INFO - PROCESS | 10435 | |6;Boyer;10744.68085106383 20:21:26 INFO - PROCESS | 10435 | |7;RegExp;40490.19607843137 20:21:26 INFO - PROCESS | 10435 | |8;Splay;500 20:21:26 INFO - PROCESS | 10435 | |9;NavierStokes;4812.5 20:21:26 INFO - PROCESS | 10435 | __end_tp_report 20:21:26 INFO - PROCESS | 10435 | __startTimestamp1459480886448__endTimestamp 20:21:26 INFO - PROCESS | 10435 | 20:21:26 INFO - PROCESS | 10435 | ------- Summary: start ------- 20:21:26 INFO - PROCESS | 10435 | Number of tests: 10 20:21:26 INFO - PROCESS | 10435 | 20:21:26 INFO - PROCESS | 10435 | [#0] Richards Cycles:1 Average:167.31 Median:167.31 stddev:0.00 (0.0%) 20:21:26 INFO - PROCESS | 10435 | Values: 167.3 20:21:26 INFO - PROCESS | 10435 | 20:21:26 INFO - PROCESS | 10435 | [#1] DeltaBlue Cycles:1 Average:169.35 Median:169.35 stddev:0.00 (0.0%) 20:21:26 INFO - PROCESS | 10435 | Values: 169.3 20:21:26 INFO - PROCESS | 10435 | 20:21:26 INFO - PROCESS | 10435 | [#2] Encrypt Cycles:1 Average:277.93 Median:277.93 stddev:0.00 (0.0%) 20:21:26 INFO - PROCESS | 10435 | Values: 277.9 20:21:26 INFO - PROCESS | 10435 | 20:21:26 INFO - PROCESS | 10435 | [#3] Decrypt Cycles:1 Average:5235.60 Median:5235.60 stddev:0.00 (0.0%) 20:21:26 INFO - PROCESS | 10435 | Values: 5235.6 20:21:26 INFO - PROCESS | 10435 | 20:21:26 INFO - PROCESS | 10435 | [#4] RayTrace Cycles:1 Average:958.77 Median:958.77 stddev:0.00 (0.0%) 20:21:26 INFO - PROCESS | 10435 | Values: 958.8 20:21:26 INFO - PROCESS | 10435 | 20:21:26 INFO - PROCESS | 10435 | [#5] Earley Cycles:1 Average:559.91 Median:559.91 stddev:0.00 (0.0%) 20:21:26 INFO - PROCESS | 10435 | Values: 559.9 20:21:26 INFO - PROCESS | 10435 | 20:21:26 INFO - PROCESS | 10435 | [#6] Boyer Cycles:1 Average:10744.68 Median:10744.68 stddev:0.00 (0.0%) 20:21:26 INFO - PROCESS | 10435 | Values: 10744.7 20:21:26 INFO - PROCESS | 10435 | 20:21:26 INFO - PROCESS | 10435 | [#7] RegExp Cycles:1 Average:40490.20 Median:40490.20 stddev:0.00 (0.0%) 20:21:26 INFO - PROCESS | 10435 | Values: 40490.2 20:21:26 INFO - PROCESS | 10435 | 20:21:26 INFO - PROCESS | 10435 | [#8] Splay Cycles:1 Average:500.00 Median:500.00 stddev:0.00 (0.0%) 20:21:26 INFO - PROCESS | 10435 | Values: 500.0 20:21:26 INFO - PROCESS | 10435 | 20:21:26 INFO - PROCESS | 10435 | [#9] NavierStokes Cycles:1 Average:4812.50 Median:4812.50 stddev:0.00 (0.0%) 20:21:26 INFO - PROCESS | 10435 | Values: 4812.5 20:21:26 INFO - PROCESS | 10435 | -------- Summary: end -------- 20:21:26 INFO - PROCESS | 10435 | 20:21:27 INFO - TEST-INFO | 10435: exit 0 20:21:27 INFO - TEST-OK | v8_7 | took 40505ms 20:21:27 INFO - SUITE-END | took 1209s 20:21:27 INFO - Completed test suite (00:20:09) 20:21:27 INFO - Working with test: dromaeo_css 20:21:27 INFO - Generating results file: dromaeo_css 20:21:27 INFO - Working with test: kraken 20:21:27 INFO - Generating results file: kraken 20:21:27 INFO - javascript benchmark 20:21:27 INFO - Working with test: v8_7 20:21:27 INFO - Generating results file: v8_7 20:21:27 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:21:27 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 20:21:27 INFO - process_Request line: dromaeo_css 7137.45 graph.html#tests=[[72,53,35]] 20:21:27 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:21:27 INFO - process_Request line: kraken 1468.40 graph.html#tests=[[232,53,35]] 20:21:27 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:21:27 INFO - process_Request line: v8_7 22057.89 graph.html#tests=[[230,53,35]] 20:21:27 INFO - RETURN: dromaeo_css: 7137.45 20:21:27 INFO - RETURN: kraken: 1468.40 20:21:27 INFO - RETURN: v8_7: 22057.89 20:21:27 INFO - javascript benchmark 20:21:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3189.6810318968105, 3236.9352612947728, 3261.037993791831, 3263.4125857345684, 3298.9010329690104, 5138.0, 5144.485551444858, 5161.122609156443, 5169.586433085354, 5193.246979188016, 5156.071907056728, 5162.432132465435, 5186.351706036746, 5195.246689230059, 5214.843554693356, 4600.493945665974, 4705.647076469261, 4733.90532189356, 4767.880802979918, 4832.879178020543, 4701.7414042227665, 4705.600023997964, 4736.171170045245, 4739.573438390544, 4746.620270378378, 4664.277037059262, 4666.346711460398, 4701.318308845232, 4741.146593613148, 4753.0, 4764.452088009872, 4798.256270278112, 4800.519948005206, 4802.375691160162, 4804.399450068741, 4719.457262414798, 4733.958529123587, 4750.524947505256, 4774.618030557547, 4804.807807687688, 4915.901681966377, 4936.0, 4987.202047672391, 5000.799968001275, 5003.849884503471, 5507.339119305669, 5515.448455154453, 5521.668699878021, 5525.585581081435, 5530.557555395559, 5382.67703937765, 5497.752601132958, 5508.834734957918, 5540.0, 5562.221289019541, 5163.3545806774155, 5163.509466600667, 5216.66091704038, 5221.582273418117, 5222.738863056832, 5570.359408668055, 5600.27196464457, 5600.607957443021, 5604.467575580314, 5623.297087864017, 5322.54758345545, 5387.81142660005, 5392.973035134799, 5397.271368365299, 5398.1902714593125, 5446.291982042309, 5479.068558345091, 5490.396056433789, 5495.642783219078, 5526.834194974157, 5454.072807622713, 5473.67157970523, 5474.178873169057, 5476.205950137288, 5479.835604931858, 5288.127458969227, 5383.192521121863, 5456.045192091368, 5477.014137455296, 5512.91730624041, 4200.369944508348, 4243.830246790094, 4247.44783178191, 4250.702450828412, 4254.744715317091, 3837.5394952605866, 3851.9422208666892, 3859.5754467008605, 3894.824732887027, 3917.6082391760597, 5179.533841954242, 5200.869978250574, 5212.113940630102, 5224.216367544823, 5239.187925871496, 5506.1190209566275, 5508.944910550923, 5510.834674959758, 5512.255845460892, 5512.6692398456225, 5092.134337162691, 5148.56237219833, 5163.8192663256605, 5203.245529398292, 5219.399769026611, 4717.363155973968, 4734.976325118352, 4745.193317136095, 4752.691075080109, 4777.498362671939, 5499.807506737325, 5554.666719996813, 5596.4403559644525, 5605.439456054443, 5615.0454422748235, 5441.891162176735, 5452.318460192476, 5493.478119578634, 5508.44915508446, 5539.196816461671, 5490.670559766427, 5499.477549632778, 5512.035393805988, 5512.476314750093, 5513.5037846594, 5314.760835762478, 5330.493603107699, 5338.8932221356135, 5357.78568857257, 5431.321084864392, 5518.724063796874, 5569.164625306236, 5569.916451253153, 5572.721363931706, 5589.965856316594, 5284.867878303073, 5330.840074797762, 5333.06671332523, 5336.3863155736035, 5372.677639341652, 5271.314729085348, 5273.6044796639635, 5326.280952071421, 5336.893262134658, 5357.946420535744, 5320.787168513216, 5339.065663508948, 5341.7062061586985, 5344.25180474726, 5344.625876188629, 5413.7834486620095, 5419.701916394636, 5428.131498960148, 5456.345238571397, 5459.535939445032, 5153.587712983027, 5259.526642602184, 5300.1519756838725, 5306.230596563554, 5388.703621300866], "unit": "score", "name": "dojo.html", "value": 5083.997374105811}, {"lowerIsBetter": false, "replicates": [552.737449711387, 574.0592850096303, 578.22517826113, 604.5345084285099, 606.2936678769235, 40589.79705101474, 40891.79554102226, 40932.181356372894, 40964.79517602411, 40990.0, 44303.55696443035, 44992.550074499246, 45095.0, 45102.77448612752, 45175.77412112935, 8773.56132193391, 9124.543772811367, 9125.269978401711, 9134.588943497525, 9149.085091490831, 8909.198172164504, 9074.546272686339, 9085.954570227139, 9103.08969103091, 9124.863127053066, 9082.500462474562, 9146.2682985361, 9180.0, 9199.172074513292, 9202.815943681122, 9040.231580315682, 9187.081291870827, 9197.632094716204, 9201.861972070425, 9205.217556507705, 9027.593758280893, 9149.359544831865, 9167.541622918827, 9169.495677737721, 9173.174414302677, 44274.33588496175, 44743.55256447427, 44777.0, 44812.77593612044, 44832.775836120934, 3502.5796904371637, 3610.9277814443826, 3937.1928754605237, 4072.7556346619003, 4218.261804184255, 33757.662423375696, 34382.48426273608, 34544.6545534544, 34555.48166777475, 34582.65417345819, 3901.239258344624, 4021.2158629067344, 4042.0905296308097, 4071.1654110907193, 4078.7419639606414, 296581.0, 297904.0, 298656.99999999785, 298961.0, 298978.0, 62497.0, 63903.0, 69307.0, 70366.42618229799, 70605.64697176481, 61722.38277617256, 61869.69065154645, 61971.0, 62095.37904620986, 62118.068228976605, 17114.315427382764, 17338.739918901225, 17366.56583585395, 17374.739378909326, 17379.826201738073, 12817.102802803714, 12947.482100715866, 12962.67593310156, 13045.217286962812, 13085.084044117011, 22226.222082227043, 22344.888275558842, 22377.32868013962, 22381.88809055944, 22538.0, 7770.45606807518, 8486.575671216538, 8560.743177704679, 8600.397972142015, 8609.612567434355, 991.281321042253, 1002.3835341265216, 1097.2977294531506, 1110.655696734015, 1155.7052951497315, 30878.228044298623, 30917.536236956465, 31144.22139446532, 31848.0, 31922.361552768816, 1079.7516571188671, 1147.225622704671, 1158.8841115888345, 1167.3287859480834, 1218.939053047344, 14141.787873181911, 14954.820028955077, 14965.92517037408, 15414.306356213998, 15793.763093553605, 364760.0, 370021.0, 370923.0, 371223.0, 371430.0, 59156.70421647864, 59516.0, 59624.0, 59713.40286597165, 59849.0, 1355.755963926483, 1407.0, 1470.1913947328926, 1506.1113942773598, 1552.8990615609948, 27961.44077118487, 28110.85944570264, 28598.857005715672, 28665.996690115746, 28893.855530722212, 43733.34399983939, 43937.56062439334, 43998.0, 44125.0, 50253.24620130774, 235232.0, 451093.0, 461479.0, 462095.0, 464210.78946051886, 34127.65872341344, 34198.65801342054, 34443.65556344505, 34472.82763586166, 34506.82746586251, 47194.76402617965, 48417.03165936732, 48507.0, 49629.0, 53416.732916336725, 37976.430353544165, 38011.42982855315, 38504.614953851225, 39087.41368879412, 39694.0, 35830.78012007911, 36479.0, 36842.8157859209, 38807.805960970014, 40099.0, 38494.80752596219, 38528.2294354117, 39418.802905985285, 39461.80269098636, 39537.60462395339, 33483.0, 34978.825105874304, 35006.82496587501, 35417.468737969466, 35698.82150589334, 26799.598006029537, 26800.463990719687, 26975.32561685895, 27088.0, 27156.185314440598], "unit": "score", "name": "ext.html", "value": 20065.53895374902}, {"lowerIsBetter": false, "replicates": [384.40801166204045, 384.94610754494374, 386.9168128852297, 388.5900375104264, 391.7394932369974, 14796.526562024606, 14875.404983800636, 16875.32498700052, 18547.16537755799, 18556.62886742264, 17531.91234043828, 17677.204525796336, 17715.202815873283, 18777.718334225, 18822.905885470554, 5882.88234235315, 6125.203723515937, 6126.7549298028025, 6147.47746441553, 6153.353897840707, 4463.553644635526, 4616.6537509686905, 6006.069059295816, 6487.351264873522, 6645.568038077534, 6616.669166541677, 6732.697028633699, 6810.0, 6838.760643377483, 6850.794476165723, 6487.448566871822, 6662.467002639825, 6669.299723529008, 6676.2989886062, 6714.227863795677, 6449.774257900998, 6461.741530338828, 6463.095166676669, 6470.6117632941705, 6474.223093228796, 21538.0, 21906.89046554773, 22663.433414164614, 22692.319230423112, 22723.772762272332, 2221.7889300516426, 2288.8855557222237, 2314.6065168921323, 2338.6024375856146, 2341.1922886604093, 13967.720645587133, 14138.50515231962, 14274.714505709931, 14342.0, 14695.11829290246, 1846.5660569766228, 1928.6914093744933, 1957.8335841453493, 2028.2698228637678, 2051.302557130568, 53879.19181212285, 54979.175312370746, 62744.37255627431, 65076.0, 66693.0, 10562.471876406149, 10820.4048777318, 10855.565777368975, 10925.344479331265, 10975.725606859733, 14329.211893345966, 14388.424463021362, 14400.855991440161, 14453.421863125357, 14558.781618275734, 7854.332381747501, 7886.250806173404, 7905.920940790634, 8074.596270186467, 8087.716929907425, 7653.0, 7889.250521200477, 7903.209679032051, 7909.1695371985115, 7955.323797477164, 4328.220920234388, 4476.574725401082, 4785.066911952205, 4860.756962151878, 4918.704877707278, 1905.3712274949235, 1941.5922656242346, 1958.3831093205595, 1974.3484650065443, 1975.2987689370354, 969.4280374579032, 974.4786539201493, 978.6476868327396, 1049.5329578337567, 1077.7305673581604, 14055.859441405659, 16256.431024914307, 16593.91703041477, 16921.7461738074, 17793.021383823754, 939.4785893828854, 995.581855620641, 1001.7495626093477, 1011.691434112588, 1015.6749840051112, 9476.0, 9680.515974201262, 9749.463779492055, 9750.707478775648, 9814.705558833246, 560342.0, 560717.0, 563340.0, 567388.0, 576026.0, 76488.0, 76900.0, 78966.0, 79254.41491170145, 80508.59745701351, 1218.031664826465, 1226.6810629236284, 1231.119749379198, 1240.522398876421, 1243.589615426889, 14604.561863144123, 14802.475724039508, 14991.700165996837, 14999.12510936133, 15025.248737563297, 35615.50691451573, 35993.28013439769, 36011.63988360083, 36112.277754444236, 37033.62966370302, 43975.78012109919, 44689.77655111704, 45944.08111837678, 46114.538854611026, 46877.0, 7615.314621684075, 7781.988341515566, 7800.570968596781, 7803.609819509115, 7811.140774514685, 11539.538418463168, 11770.823437648613, 11811.527538898692, 12009.159358844798, 12193.939030304791, 9798.51007449639, 10240.795184096127, 10391.53238104272, 10425.061744442733, 10531.104856087319, 7531.8117047074265, 9775.657851975147, 10102.0, 10344.224183186441, 10472.31929924583, 9871.457069861226, 10243.897561024593, 10597.41714205726, 10611.628592999208, 10761.085307748928, 7288.453365997678, 7470.551766894004, 7488.513246638951, 7615.847683046419, 7676.424268179797, 9304.813903721752, 10003.649872254437, 10270.383776973405, 10298.3820970742, 10712.73218169552], "unit": "score", "name": "jquery.html", "value": 8883.051832665798}, {"lowerIsBetter": false, "replicates": [1347.6091933339333, 1500.5948393933638, 1515.4392874636387, 1732.722764357703, 1890.0644181130333, 6946.0, 7570.697172113116, 7723.382129429653, 7738.613069346538, 7756.92243077569, 7669.041369828771, 7722.420818438612, 7792.805179870506, 7798.0642322921185, 7802.570858602775, 2316.721993360799, 2337.9415514612188, 2339.6256598944174, 2342.917997870075, 2343.53129374125, 2296.701428814252, 2316.6061769499224, 2368.52629474105, 2373.52529494101, 2384.1178763857397, 2353.211674089174, 2372.5610762008996, 2373.0, 2377.072941552796, 2383.4994651123284, 2342.8711420871846, 2361.327021798788, 2364.255259593231, 2368.301351101429, 2381.9285421437385, 2300.7584203658544, 2305.8616483011074, 2311.5376924615143, 2313.340697901107, 2315.166540045582, 8017.759467215993, 8061.435699501038, 8064.435489515737, 8065.354771618257, 8068.072171700271, 4534.455865296186, 4652.302154676826, 4738.241881298975, 4754.809807607691, 4778.354922085508, 3004.549317602355, 3010.68387819278, 3040.9847950760327, 3066.8466576671076, 3081.984590077035, 1035.585765693721, 1046.9479819553685, 1051.363924825485, 1064.6805958212583, 1066.8399740039056, 10785.514651840607, 10789.83815242772, 10791.622293219778, 10795.0, 10806.02745752886, 4023.8591649292134, 4030.879073627796, 4083.1017176221185, 4107.281225785536, 4108.198901214294, 9260.351775375659, 9277.0, 9284.814303714023, 9286.164245217962, 9290.210332121711, 4757.119932812441, 4757.762111894392, 4768.427788665383, 4769.093872164278, 4769.642276829251, 3969.186316805048, 4088.8160032798596, 4290.2063118322585, 4326.372675961968, 4384.714993525411, 3741.7006639468777, 3760.172761992357, 3779.5842457329672, 3802.0, 3834.4631751554803, 1218.4273391505978, 1224.0452447091104, 1228.6621179175797, 1231.0, 1239.962801115968, 1437.0802686280788, 1437.6477762947936, 1439.0574173916102, 1459.073488334915, 1460.488828909873, 7478.252174782587, 7479.439042071866, 7482.625868706543, 7521.887171692429, 7538.698452061966, 525.3606351287237, 531.7208465555615, 533.2214966149388, 533.7704786941574, 536.0164098878602, 5830.883382332415, 5914.970425147847, 5915.58590898633, 5922.170896074553, 5927.673977931169, 9154.176124148726, 9259.953700231456, 9409.905900940903, 9433.056694330511, 9452.8582071269, 9108.59011344491, 9261.398009129385, 9278.257739380833, 9280.118388753057, 9292.256619470427, 7238.167610724729, 7424.0, 7430.479866409408, 7496.437767167485, 7507.436942229246, 7354.48518603714, 7425.9628701856145, 7430.219826918095, 7437.0, 7471.21552237029, 8282.83434331298, 8499.617517211616, 8569.0, 8616.396852220536, 8645.178708022728, 8549.743507694779, 8594.484330940164, 8635.179657932485, 8679.132086791271, 8734.170253825876, 6459.386358295955, 6559.048937903882, 6853.691583878638, 6965.686544105629, 7048.471364647569, 7532.698692052257, 7536.547807131589, 7586.468947173645, 7590.582517961565, 7596.468247222641, 6885.0, 7030.578165310098, 7068.187158476841, 7195.496315257882, 7271.672774725044, 7093.680784364819, 7115.359617634438, 7139.643017849191, 7191.244919283609, 7210.242924492853, 7082.220955694973, 7136.250693677297, 7294.416446684147, 7296.525725827804, 7299.744508942162, 6589.505787066085, 6599.109120268894, 6600.735970561123, 6620.702068407029, 6621.172353455818, 6703.865922681422, 6744.190697116182, 6791.2190098139345, 6808.5914845109455, 6819.318068193141], "unit": "score", "name": "mootools.html", "value": 4491.967995703975}, {"lowerIsBetter": false, "replicates": [341.96067452242994, 346.5564077980186, 349.1376300537673, 356.8412056634795, 360.9981950090251, 5960.64236145831, 5985.521158307336, 5988.341282458926, 6002.009668404708, 6007.339192688801, 5696.601237913348, 5782.942170578293, 5814.796482123126, 5883.88232235355, 5917.28992520897, 4612.97693511532, 4664.7434391108645, 4677.90069333708, 4678.391809064817, 4678.6023188028885, 4487.5736805003635, 4677.88305292367, 4679.976600117012, 4682.484926658065, 4702.083093796711, 4499.46006479223, 4542.909141817162, 4565.292379681155, 4577.633789296865, 4584.931226031612, 4538.228501154812, 4577.473590537097, 4587.921838367997, 4591.471980722226, 4599.793009314589, 4079.000644842003, 4080.0615858352744, 4085.8151136170477, 4088.7342322749223, 4097.221527909717, 5540.252065971123, 5661.971690141564, 5665.5467562594895, 5672.120821272668, 5672.716364181816, 5331.600129990266, 5347.973260133714, 5349.946500534984, 5364.088105022156, 5369.919451208235, 6279.34066922971, 6286.9056964145575, 6289.119523266746, 6293.874122517524, 6325.051242313643, 4504.0, 4509.932351014738, 4511.233090374644, 4511.819527218908, 4514.932276015862, 6459.160309159826, 6525.804225873231, 6540.542162048659, 6588.439982601484, 6594.571352862049, 4530.886727831765, 4532.682712210114, 4538.183127037165, 4538.863834084983, 4540.182767101887, 4584.15193189261, 4589.862304130881, 4591.219492686251, 4592.88517787058, 4593.63250939924, 5268.525832675077, 5270.1040823060175, 5278.366596008504, 5280.656757310762, 5287.576993840484, 6217.96891015542, 6310.305866354697, 6315.494760419156, 6328.873422531524, 6339.492840572743, 1613.2498388249521, 1624.6994306053418, 1626.8698504119643, 1627.5117464760524, 1629.0470075006017, 1092.4592326798127, 1093.781243751237, 1096.7313008312856, 1097.8627671541058, 1098.3958822647671, 6151.630902145886, 6153.661548614779, 6156.569040167145, 6156.6921653917125, 6160.353162917919, 6342.365763423713, 6533.967330163414, 6538.346165383518, 6545.5090868184125, 6550.475961923034, 6037.305709843336, 6044.032954727222, 6141.907871381933, 6144.969275153596, 6147.815565533041, 3466.6706662866986, 3535.222251104753, 3536.8938931832085, 3537.7877327359924, 3541.026217790128, 6632.767853125118, 6757.391834734897, 6763.458923286125, 6772.966135169293, 6776.830579235559, 6733.0, 6736.629485378351, 6743.966280168568, 6747.392734653807, 6748.966255168692, 6760.661966901635, 6762.391384775394, 6769.661516924134, 6769.8646027079185, 6777.49168812341, 6420.0, 6553.934460655332, 6566.507511936719, 6571.57284776488, 6585.20977482686, 6457.225132984072, 6462.3537646235, 6462.386073323027, 6470.352964703492, 6472.0, 6752.831179220559, 6754.459643228628, 6758.966205168943, 6764.695588698619, 6780.559263647847, 4556.33933079695, 4561.771911404483, 4562.270036794097, 4562.315652652129, 4566.429196350457, 6416.13382193398, 6580.539362244788, 6583.144191255297, 6587.0, 6593.835154121185, 6419.45434638061, 6423.325550817097, 6426.0, 6426.678666066771, 6427.453666438218, 6317.936820631735, 6401.327860574573, 6402.90395644075, 6404.1674582304, 6413.679316034087, 6347.968260158855, 6381.680915954276, 6382.0745991831855, 6386.872262554816, 6390.329015453311, 6425.550211485338, 6431.324710905475, 6444.162258906312, 6445.16212892321, 6453.0, 6124.816255512342, 6239.344868788712, 6240.063990401476, 6246.281677606951, 6252.468540174136], "unit": "score", "name": "prototype.html", "value": 4813.917724963046}, {"lowerIsBetter": false, "replicates": [918.4581097152675, 925.5603588295556, 941.5857022909919, 946.2430055955236, 958.519088009026, 14609.196494192814, 14719.852801471981, 14726.0, 14733.484328048507, 14771.926140369296, 13337.0, 13820.308984550782, 13901.096428732126, 13967.860321396784, 13995.93002034991, 675.0886303490273, 691.3190507350256, 692.0726226856012, 886.9600867960941, 911.1890417528405, 697.7174244431013, 874.567089290802, 904.0913881549034, 905.710172744722, 906.2976193450063, 942.8585712143165, 949.838527450335, 950.6007476859736, 952.8237276103943, 953.4708236928502, 782.8434313137395, 806.1454857850639, 943.9103285187896, 945.9290553208502, 946.0633972367375, 684.5687217053274, 697.1564407067455, 703.0087576517086, 704.1057856522189, 704.5068452083563, 14452.783208251885, 14497.855021449755, 14502.41990320386, 14524.70950580993, 14556.0538564994, 13315.467381304736, 13804.516841910485, 13929.512467063705, 14126.01117921746, 14205.715885682228, 11120.666380008532, 11125.777484450266, 11214.775704485946, 11226.663200103929, 11272.323660580392, 3842.711796615265, 3879.4180872869015, 3898.922021559553, 3936.960630393688, 3940.8817735467983, 49086.7545662273, 49268.26097608539, 49972.25041624415, 50195.0, 50485.495145048444, 10337.276390652733, 10421.426821524738, 10699.411532365795, 10835.349879007284, 10910.181736369805, 19042.33351832679, 19512.414627560913, 19540.022998850283, 19557.119929603203, 19569.8043019568, 8064.637091330904, 8097.433179677366, 8119.512829230265, 8176.754697359089, 8268.421210515206, 4185.100203456272, 4270.572942705767, 4496.842610508616, 4624.606908412756, 4679.134360143385, 3244.5944256967878, 3257.250832308582, 3275.082976766509, 3294.8682052718104, 3304.0583433721754, 566.9404712505127, 570.5264630356794, 572.9197912292283, 586.6040422714735, 594.4917095883044, 546.519063224368, 628.955973081889, 632.339205530222, 641.470786601056, 756.0247281007439, 9294.163525282622, 9328.39365441244, 9338.299627527962, 9443.858342124873, 9478.478683672463, 640.4108220437209, 641.1760887259849, 712.9394001509826, 734.0970606154353, 791.7347688524409, 4329.826806927751, 4375.212461756851, 4393.956060439418, 4547.090581883636, 4577.931331030038, 58080.70959645175, 58260.70869645625, 58292.4170758287, 58396.0, 58463.415365846646, 52039.479605203465, 53928.730356347965, 54314.0, 54364.0, 54851.72574137104, 46612.3008154878, 48186.759066204446, 48940.265896010875, 49422.25866612004, 50187.24719129216, 9043.63825447001, 9212.355135140477, 9227.261819054595, 9264.212541934012, 9279.211267042378, 35565.46651800173, 35806.46290305595, 36029.27941441209, 36468.0, 36966.815165923996, 44436.33345499885, 47706.0, 47850.0, 48296.0, 48422.75788621034, 11840.940795295968, 11934.820977685167, 11959.103067269816, 12367.319797411228, 12471.249170528983, 11815.527378904748, 12976.286304253357, 13025.544105956626, 13349.532766353132, 13502.257375844423, 12442.191257568229, 12591.559295424617, 12599.0, 12689.87310126887, 13249.668758280735, 12236.265824050586, 12501.93749031249, 12635.431405586954, 12936.417861196456, 13199.340032998503, 11435.142364322875, 11527.481263343001, 11786.941065294619, 11870.584529541424, 12658.11393202467, 10197.643082492077, 10251.077403033763, 10620.84068738985, 10702.571897124028, 10787.67636970892, 10239.18086553059, 10615.522301496298, 10641.414722190353, 10664.89335106639, 10677.679669609925], "unit": "score", "name": "yui.html", "value": 6746.240257589005}], "name": "dromaeo_css", "value": 7137.447611397329}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 107.0, 110.0, 110.0, 110.0, 100.0, 111.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [149.0, 125.0, 148.0, 168.0, 125.0, 151.0, 152.0, 126.0, 162.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 143.1}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 159.0, 161.0, 160.0, 158.0, 160.0, 161.0, 162.0, 159.0], "unit": "score", "name": "audio-dft", "value": 160.2}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 73.0, 157.0, 75.0, 73.0, 75.0, 76.0, 145.0, 75.0], "unit": "score", "name": "audio-fft", "value": 89.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 150.0, 96.0, 95.0, 96.0, 138.0, 96.0, 97.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 108.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [54.0, 61.0, 54.0, 54.0, 54.0, 55.0, 55.0, 54.0, 53.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 64.0, 64.0, 64.0, 63.0, 65.0, 64.0, 63.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 79.0, 77.0, 78.0, 76.0, 77.0, 77.0, 80.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 77.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 113.0, 111.0, 117.0, 113.0, 109.0, 108.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 111.8}, {"lowerIsBetter": true, "replicates": [135.0, 134.0, 133.0, 133.0, 134.0, 132.0, 134.0, 131.0, 131.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 132.9}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 63.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.0}], "name": "kraken", "value": 1468.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.3080140538732], "unit": "score", "name": "Richards", "value": 211.00005399999995}, {"lowerIsBetter": false, "replicates": [169.34801016088062], "unit": "score", "name": "DeltaBlue", "value": 390.4267899999999}, {"lowerIsBetter": false, "replicates": [277.9321845469705], "unit": "score", "name": "Encrypt", "value": 957.7192379999997}, {"lowerIsBetter": false, "replicates": [5235.602094240838], "unit": "score", "name": "Decrypt", "value": 50.84057100000005}, {"lowerIsBetter": false, "replicates": [958.7727708533077], "unit": "score", "name": "RayTrace", "value": 771.8085270000001}, {"lowerIsBetter": false, "replicates": [559.9104143337066], "unit": "score", "name": "Earley", "value": 1190.3029180000005}, {"lowerIsBetter": false, "replicates": [10744.68085106383], "unit": "score", "name": "Boyer", "value": 62.02724950495052}, {"lowerIsBetter": false, "replicates": [40490.19607843137], "unit": "score", "name": "RegExp", "value": 22.498903147699753}, {"lowerIsBetter": false, "replicates": [500.0], "unit": "score", "name": "Splay", "value": 162.98200000000003}, {"lowerIsBetter": false, "replicates": [4812.5], "unit": "score", "name": "NavierStokes", "value": 308.3636363636364}], "name": "v8_7", "value": 22057.886000788556}]} 20:21:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "22057.89"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1468.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7137.45"}}} 20:21:27 INFO - Return code: 0 20:21:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 20:21:27 INFO - # TBPL SUCCESS # 20:21:27 INFO - Running post-action listener: _resource_record_post_action 20:21:27 INFO - Running post-run listener: _resource_record_post_run 20:21:29 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 20480; Write bytes: 234774528; Read time: 36; Write time: 159600 20:21:29 INFO - install - Wall time: 13s; CPU: 13.0%; Read bytes: 0; Write bytes: 14200832; Read time: 0; Write time: 3124 20:21:29 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 20480; Write bytes: 220573696; Read time: 36; Write time: 156476 20:21:29 INFO - Running post-run listener: _upload_blobber_files 20:21:29 INFO - Blob upload gear active. 20:21:29 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 20:21:29 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 20:21:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 20:21:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Beta -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 20:21:29 INFO - (blobuploader) - INFO - Open directory for files ... 20:21:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 20:21:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:21:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:30 INFO - (blobuploader) - INFO - Done attempting. 20:21:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:21:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:21:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:21:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:21:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:21:30 INFO - (blobuploader) - INFO - Done attempting. 20:21:30 INFO - (blobuploader) - INFO - Iteration through files over. 20:21:30 INFO - Return code: 0 20:21:30 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 20:21:30 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 20:21:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/854f28c3bfe7ad5d4ec34f1b9bb3bb2059f39a937ad263957c21430ddd831bac9631967e47f72eaf500c63c42213b2d48a7ce985d404e165429c1990a17ae928", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a7af1785112a9279158c4454f0da98002cfa4b52ebc328ab2684cf85f08a418035c909f6a8f9d675c9f8a1c96806c81b1f67b85e28f639c5bad6ee0c7540587"} 20:21:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 20:21:30 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 20:21:30 INFO - Contents: 20:21:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/854f28c3bfe7ad5d4ec34f1b9bb3bb2059f39a937ad263957c21430ddd831bac9631967e47f72eaf500c63c42213b2d48a7ce985d404e165429c1990a17ae928", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a7af1785112a9279158c4454f0da98002cfa4b52ebc328ab2684cf85f08a418035c909f6a8f9d675c9f8a1c96806c81b1f67b85e28f639c5bad6ee0c7540587"} 20:21:30 INFO - Running post-run listener: copy_logs_to_upload_dir 20:21:30 INFO - Copying logs to upload dir... 20:21:30 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 20:21:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1632.496053 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 27 mins, 12 secs) (at 2016-03-31 20:21:30.782303) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-31 20:21:30.786212) ========= 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=fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/854f28c3bfe7ad5d4ec34f1b9bb3bb2059f39a937ad263957c21430ddd831bac9631967e47f72eaf500c63c42213b2d48a7ce985d404e165429c1990a17ae928", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a7af1785112a9279158c4454f0da98002cfa4b52ebc328ab2684cf85f08a418035c909f6a8f9d675c9f8a1c96806c81b1f67b85e28f639c5bad6ee0c7540587"} build_url:https://queue.taskcluster.net/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011271 build_url: 'https://queue.taskcluster.net/v1/task/Qn-x6inKTNarhtaKL8vb4Q/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/854f28c3bfe7ad5d4ec34f1b9bb3bb2059f39a937ad263957c21430ddd831bac9631967e47f72eaf500c63c42213b2d48a7ce985d404e165429c1990a17ae928", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7a7af1785112a9279158c4454f0da98002cfa4b52ebc328ab2684cf85f08a418035c909f6a8f9d675c9f8a1c96806c81b1f67b85e28f639c5bad6ee0c7540587"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-31 20:21:30.811203) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 20:21:30.811556) ========= 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=fa44defc139c4ba8574fe040000001db-1459479084.920573-163692659 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-31 20:21:30.895715) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-31 20:21:30.896086) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-31 20:21:30.896485) ========= ========= Total master_lag: 0.60 =========