builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1458868051.47 results: success (0) buildid: 20160324152934 builduid: fe171b9d08d44a7bbeee1e818327203d revision: b2bc679410410214e1fd9953deb1439182332aa5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:31.465924) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:31.466367) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:31.466646) ========= 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=337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006337 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:31.495481) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:31.495760) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:31.516268) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:31.516559) ========= 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=337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:31.565681) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:31.565955) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:31.566286) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:31.566557) ========= 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=337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-24 18:07:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-03-24 18:07:31 (46.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097971 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:31.676641) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:31.676941) ========= 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=337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022480 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:31.726342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:31.726892) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b2bc679410410214e1fd9953deb1439182332aa5 --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 b2bc679410410214e1fd9953deb1439182332aa5 --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=337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-24 18:07:31,843 truncating revision to first 12 chars 2016-03-24 18:07:31,843 Setting DEBUG logging. 2016-03-24 18:07:31,843 attempt 1/10 2016-03-24 18:07:31,843 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b2bc67941041?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 18:07:32,086 unpacking tar archive at: mozilla-beta-b2bc67941041/testing/mozharness/ program finished with exit code 0 elapsedTime=0.526776 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:32.267382) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:32.267827) ========= echo b2bc679410410214e1fd9953deb1439182332aa5 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b2bc679410410214e1fd9953deb1439182332aa5'] 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=337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b2bc679410410214e1fd9953deb1439182332aa5 program finished with exit code 0 elapsedTime=0.003908 script_repo_revision: 'b2bc679410410214e1fd9953deb1439182332aa5' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:32.316844) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:32.317247) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 18:07:32.327042) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-03-24 18:07:32.327328) ========= /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=337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:07:32 INFO - MultiFileLogger online at 20160324 18:07:32 in /builds/slave/test-pgo 18:07:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 18:07:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:07:32 INFO - {'append_to_log': False, 18:07:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:07:32 INFO - 'blob_upload_branch': 'Mozilla-Beta', 18:07:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:07:32 INFO - 'branch': 'Mozilla-Beta', 18:07:32 INFO - 'buildbot_json_path': 'buildprops.json', 18:07:32 INFO - 'config_files': ('talos/linux_config.py',), 18:07:32 INFO - 'default_actions': ('clobber', 18:07:32 INFO - 'read-buildbot-config', 18:07:32 INFO - 'download-and-extract', 18:07:32 INFO - 'populate-webroot', 18:07:32 INFO - 'create-virtualenv', 18:07:32 INFO - 'install', 18:07:32 INFO - 'run-tests'), 18:07:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:07:32 INFO - 'download_minidump_stackwalk': True, 18:07:32 INFO - 'download_symbols': 'ondemand', 18:07:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:07:32 INFO - 'tooltool.py': '/tools/tooltool.py', 18:07:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:07:32 INFO - '/tools/misc-python/virtualenv.py')}, 18:07:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:07:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:07:32 INFO - 'installer_path': 'installer.exe', 18:07:32 INFO - 'log_level': 'info', 18:07:32 INFO - 'log_name': 'talos', 18:07:32 INFO - 'log_to_console': True, 18:07:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:07:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:07:32 INFO - 'opt_config_files': (), 18:07:32 INFO - 'pip_index': False, 18:07:32 INFO - 'sps_profile': False, 18:07:32 INFO - 'sps_profile_interval': 0, 18:07:32 INFO - 'suite': 'dromaeojs', 18:07:32 INFO - 'system_bits': '32', 18:07:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:07:32 INFO - 'title': 'talos-linux64-ix-060', 18:07:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:07:32 INFO - 'use_talos_json': True, 18:07:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:07:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:07:32 INFO - 'work_dir': 'build'} 18:07:32 INFO - ##### 18:07:32 INFO - ##### Running clobber step. 18:07:32 INFO - ##### 18:07:32 INFO - Running pre-action listener: _resource_record_pre_action 18:07:32 INFO - Running main action method: clobber 18:07:32 INFO - rmtree: /builds/slave/test-pgo/build 18:07:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:07:33 INFO - Running post-action listener: _resource_record_post_action 18:07:33 INFO - ##### 18:07:33 INFO - ##### Running read-buildbot-config step. 18:07:33 INFO - ##### 18:07:33 INFO - Running pre-action listener: _resource_record_pre_action 18:07:33 INFO - Running main action method: read_buildbot_config 18:07:33 INFO - Using buildbot properties: 18:07:33 INFO - { 18:07:33 INFO - "project": "", 18:07:33 INFO - "product": "firefox", 18:07:33 INFO - "script_repo_revision": "production", 18:07:33 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 18:07:33 INFO - "repository": "", 18:07:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 18:07:33 INFO - "buildid": "20160324152934", 18:07:33 INFO - "pgo_build": "True", 18:07:33 INFO - "basedir": "/builds/slave/test-pgo", 18:07:33 INFO - "buildnumber": 147, 18:07:33 INFO - "slavename": "talos-linux64-ix-060", 18:07:33 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:07:33 INFO - "platform": "ubuntu64_hw", 18:07:33 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 18:07:33 INFO - "branch": "mozilla-beta", 18:07:33 INFO - "repo_path": "releases/mozilla-beta", 18:07:33 INFO - "revision": "b2bc679410410214e1fd9953deb1439182332aa5", 18:07:33 INFO - "stage_platform": "linux64-pgo", 18:07:33 INFO - "builduid": "fe171b9d08d44a7bbeee1e818327203d", 18:07:33 INFO - "slavebuilddir": "test" 18:07:33 INFO - } 18:07:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 18:07:33 INFO - Running post-action listener: _resource_record_post_action 18:07:33 INFO - ##### 18:07:33 INFO - ##### Running download-and-extract step. 18:07:33 INFO - ##### 18:07:33 INFO - Running pre-action listener: _resource_record_pre_action 18:07:33 INFO - Running main action method: download_and_extract 18:07:33 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:07:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:33 INFO - https://queue.taskcluster.net/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:07:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/test_packages.json 18:07:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/test_packages.json 18:07:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:07:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:07:38 INFO - Downloaded 1412 bytes. 18:07:38 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:07:38 INFO - Using the following test package requirements: 18:07:38 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 18:07:38 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 18:07:38 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 18:07:38 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 18:07:38 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 18:07:38 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 18:07:38 INFO - u'jsshell-linux-x86_64.zip'], 18:07:38 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 18:07:38 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 18:07:38 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 18:07:38 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 18:07:38 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 18:07:38 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 18:07:38 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 18:07:38 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 18:07:38 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 18:07:38 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 18:07:38 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 18:07:38 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 18:07:38 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:38 INFO - https://queue.taskcluster.net/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:07:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 18:07:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 18:07:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/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 18:07:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/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 18:07:41 INFO - Downloaded 23107525 bytes. 18:07:41 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'] 18:07:41 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 18:07:42 INFO - Return code: 0 18:07:42 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 18:07:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:42 INFO - https://queue.taskcluster.net/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:07:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 18:07:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 18:07:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/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 18:07:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/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 18:07:52 INFO - Downloaded 23107525 bytes. 18:07:52 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'] 18:07:52 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 18:07:54 INFO - Return code: 0 18:07:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:07:54 INFO - https://queue.taskcluster.net/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:07:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 18:07:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 18:07:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/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 18:07:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/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 18:07:55 INFO - Downloaded 10801548 bytes. 18:07:55 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'] 18:07:55 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 18:07:55 INFO - Return code: 0 18:07: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')]} 18:07:55 INFO - https://queue.taskcluster.net/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:07:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 18:07:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 18:07:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/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 18:07:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/U1u41wmtTbK0lb_4geKIVw/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 18:07:56 INFO - Downloaded 52852804 bytes. 18:07:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 18:07:56 INFO - mkdir: /builds/slave/test-pgo/properties 18:07:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:07:56 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:07:56 INFO - Contents: 18:07:56 INFO - build_url:https://queue.taskcluster.net/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 18:07:57 INFO - Running post-action listener: _resource_record_post_action 18:07:57 INFO - Running post-action listener: set_extra_try_arguments 18:07:57 INFO - ##### 18:07:57 INFO - ##### Running populate-webroot step. 18:07:57 INFO - ##### 18:07:57 INFO - Running pre-action listener: _resource_record_pre_action 18:07:57 INFO - Running main action method: populate_webroot 18:07:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:07:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:07:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:07:57 INFO - '--tppagecycles', 18:07:57 INFO - '7'], 18:07:57 INFO - 'tests': ['tsvgm']}}, 18:07:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:07:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:07:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:07:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:07:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:07:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:07:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:07:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:57 INFO - 'talos_options': ['--e10s'], 18:07:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:07:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:57 INFO - 'tests': ['damp', 'tps']}, 18:07:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:57 INFO - 'talos_options': ['--e10s'], 18:07:57 INFO - 'tests': ['damp', 'tps']}, 18:07:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:07:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:07:57 INFO - 'other': {'tests': ['a11yr', 18:07:57 INFO - 'ts_paint', 18:07:57 INFO - 'tpaint', 18:07:57 INFO - 'sessionrestore', 18:07:57 INFO - 'sessionrestore_no_auto_restore']}, 18:07:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:07:57 INFO - 'tests': ['a11yr', 18:07:57 INFO - 'ts_paint', 18:07:57 INFO - 'tpaint', 18:07:57 INFO - 'sessionrestore', 18:07:57 INFO - 'sessionrestore_no_auto_restore']}, 18:07:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:07:57 INFO - 'tests': ['a11yr', 18:07:57 INFO - 'ts_paint', 18:07:57 INFO - 'tpaint', 18:07:57 INFO - 'sessionrestore', 18:07:57 INFO - 'sessionrestore_no_auto_restore']}, 18:07:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:07:57 INFO - 'tests': ['a11yr', 18:07:57 INFO - 'ts_paint', 18:07:57 INFO - 'tpaint', 18:07:57 INFO - 'sessionrestore', 18:07:57 INFO - 'sessionrestore_no_auto_restore']}, 18:07:57 INFO - 'other_l64': {'tests': ['a11yr', 18:07:57 INFO - 'ts_paint', 18:07:57 INFO - 'tpaint', 18:07:57 INFO - 'sessionrestore', 18:07:57 INFO - 'sessionrestore_no_auto_restore']}, 18:07:57 INFO - 'other_nol64': {'tests': ['a11yr', 18:07:57 INFO - 'ts_paint', 18:07:57 INFO - 'tpaint', 18:07:57 INFO - 'sessionrestore', 18:07:57 INFO - 'sessionrestore_no_auto_restore']}, 18:07:57 INFO - 'svgr': {'tests': ['tsvgx', 18:07:57 INFO - 'tsvgr_opacity', 18:07:57 INFO - 'tart', 18:07:57 INFO - 'tscrollx', 18:07:57 INFO - 'cart']}, 18:07:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:07:57 INFO - 'tests': ['tsvgx', 18:07:57 INFO - 'tsvgr_opacity', 18:07:57 INFO - 'tart', 18:07:57 INFO - 'tscrollx', 18:07:57 INFO - 'cart']}, 18:07:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:57 INFO - 'tests': ['tp5o']}, 18:07:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:57 INFO - 'talos_options': ['--e10s'], 18:07:57 INFO - 'tests': ['tp5o']}, 18:07:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:57 INFO - 'talos_options': ['--xperf_path', 18:07:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:07:57 INFO - 'tests': ['tp5n']}, 18:07:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:07:57 INFO - 'talos_options': ['--e10s', 18:07:57 INFO - '--xperf_path', 18:07:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:07:57 INFO - 'tests': ['tp5n']}}, 18:07:57 INFO - 'talos.zip': {'path': '', 18:07:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:07:57 INFO - Running post-action listener: _resource_record_post_action 18:07:57 INFO - ##### 18:07:57 INFO - ##### Running create-virtualenv step. 18:07:57 INFO - ##### 18:07:57 INFO - Running pre-action listener: _resource_record_pre_action 18:07:57 INFO - Running main action method: create_virtualenv 18:07:57 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:07:57 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 18:07:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:07:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:07:57 INFO - Using real prefix '/usr' 18:07:57 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:07:58 INFO - Installing distribute.............................................................................................................................................................................................done. 18:08:00 INFO - Installing pip.................done. 18:08:00 INFO - Return code: 0 18:08:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:08: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')]} 18:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08: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')]} 18:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2afcca0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e2290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574850>, '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 0x14e0330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e07c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', '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 18:08: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:08: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 pip>=1.5 18:08:00 INFO - Using env: {'DISPLAY': ':0', 18:08:00 INFO - 'HOME': '/home/cltbld', 18:08:00 INFO - 'LANG': 'en_US.UTF-8', 18:08:00 INFO - 'LANGUAGE': 'en_US:en', 18:08:00 INFO - 'LOGNAME': 'cltbld', 18:08:00 INFO - 'MAIL': '/var/mail/cltbld', 18:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:00 INFO - 'MOZ_NO_REMOTE': '1', 18:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:00 INFO - 'NO_EM_RESTART': '1', 18:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:08:00 INFO - 'PWD': '/builds/slave/test-pgo', 18:08:00 INFO - 'SHELL': '/bin/bash', 18:08:00 INFO - 'SHLVL': '1', 18:08:00 INFO - 'TERM': 'linux', 18:08:00 INFO - 'TMOUT': '86400', 18:08:00 INFO - 'USER': 'cltbld', 18:08:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', 18:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:00 INFO - '_': '/tools/buildbot/bin/python'} 18:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:00 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 18:08:00 INFO - Cleaning up... 18:08:00 INFO - Return code: 0 18:08:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:08: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')]} 18:08:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08: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')]} 18:08:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08: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', '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 0x7f2afcca0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e2290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574850>, '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 0x14e0330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e07c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', '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 18:08: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:08: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 psutil>=0.7.1 18:08:00 INFO - Using env: {'DISPLAY': ':0', 18:08:00 INFO - 'HOME': '/home/cltbld', 18:08:00 INFO - 'LANG': 'en_US.UTF-8', 18:08:00 INFO - 'LANGUAGE': 'en_US:en', 18:08:00 INFO - 'LOGNAME': 'cltbld', 18:08:00 INFO - 'MAIL': '/var/mail/cltbld', 18:08:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:00 INFO - 'MOZ_NO_REMOTE': '1', 18:08:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:00 INFO - 'NO_EM_RESTART': '1', 18:08:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:08:00 INFO - 'PWD': '/builds/slave/test-pgo', 18:08:00 INFO - 'SHELL': '/bin/bash', 18:08:00 INFO - 'SHLVL': '1', 18:08:00 INFO - 'TERM': 'linux', 18:08:00 INFO - 'TMOUT': '86400', 18:08:00 INFO - 'USER': 'cltbld', 18:08:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', 18:08:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:00 INFO - '_': '/tools/buildbot/bin/python'} 18:08:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:00 INFO - Downloading/unpacking psutil>=0.7.1 18:08: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 18:08: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 18:08: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 18:08: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 18:08: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 18:08: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 18:08:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:08:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:08:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:08:02 INFO - Installing collected packages: psutil 18:08:02 INFO - Running setup.py install for psutil 18:08:02 INFO - building 'psutil._psutil_linux' extension 18:08:02 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 18:08:02 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 18:08:02 INFO - building 'psutil._psutil_posix' extension 18:08:02 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 18:08:03 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 18:08:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:08:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:08:03 INFO - Successfully installed psutil 18:08:03 INFO - Cleaning up... 18:08:03 INFO - Return code: 0 18:08:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:08:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2afcca0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e2290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574850>, '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 0x14e0330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e07c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', '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 18:08:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:08:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:08:03 INFO - Using env: {'DISPLAY': ':0', 18:08:03 INFO - 'HOME': '/home/cltbld', 18:08:03 INFO - 'LANG': 'en_US.UTF-8', 18:08:03 INFO - 'LANGUAGE': 'en_US:en', 18:08:03 INFO - 'LOGNAME': 'cltbld', 18:08:03 INFO - 'MAIL': '/var/mail/cltbld', 18:08:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:03 INFO - 'MOZ_NO_REMOTE': '1', 18:08:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:03 INFO - 'NO_EM_RESTART': '1', 18:08:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:08:03 INFO - 'PWD': '/builds/slave/test-pgo', 18:08:03 INFO - 'SHELL': '/bin/bash', 18:08:03 INFO - 'SHLVL': '1', 18:08:03 INFO - 'TERM': 'linux', 18:08:03 INFO - 'TMOUT': '86400', 18:08:03 INFO - 'USER': 'cltbld', 18:08:03 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', 18:08:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:03 INFO - '_': '/tools/buildbot/bin/python'} 18:08:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:08: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 18:08: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 18:08: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 18:08: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 18:08: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 18:08: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 18:08:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:08:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:08:05 INFO - Installing collected packages: mozsystemmonitor 18:08:05 INFO - Running setup.py install for mozsystemmonitor 18:08:05 INFO - Successfully installed mozsystemmonitor 18:08:05 INFO - Cleaning up... 18:08:05 INFO - Return code: 0 18:08:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:05 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 0x7f2afcca0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e2290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574850>, '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 0x14e0330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e07c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', '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 18:08:05 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 18:08:05 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 18:08:05 INFO - Using env: {'DISPLAY': ':0', 18:08:05 INFO - 'HOME': '/home/cltbld', 18:08:05 INFO - 'LANG': 'en_US.UTF-8', 18:08:05 INFO - 'LANGUAGE': 'en_US:en', 18:08:05 INFO - 'LOGNAME': 'cltbld', 18:08:05 INFO - 'MAIL': '/var/mail/cltbld', 18:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:05 INFO - 'MOZ_NO_REMOTE': '1', 18:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:05 INFO - 'NO_EM_RESTART': '1', 18:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:08:05 INFO - 'PWD': '/builds/slave/test-pgo', 18:08:05 INFO - 'SHELL': '/bin/bash', 18:08:05 INFO - 'SHLVL': '1', 18:08:05 INFO - 'TERM': 'linux', 18:08:05 INFO - 'TMOUT': '86400', 18:08:05 INFO - 'USER': 'cltbld', 18:08:05 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', 18:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:05 INFO - '_': '/tools/buildbot/bin/python'} 18:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:05 INFO - Downloading/unpacking blobuploader==1.2.4 18:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:08:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:07 INFO - Downloading blobuploader-1.2.4.tar.gz 18:08:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:08:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:08:07 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 18:08:07 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 18:08:07 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 18:08:07 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 18:08:07 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 18:08:07 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 18:08:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:08:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:08:08 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 18:08:08 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 18:08:08 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 18:08:08 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 18:08:08 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 18:08:08 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 18:08:08 INFO - Downloading docopt-0.6.1.tar.gz 18:08:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:08:08 INFO - Installing collected packages: blobuploader, requests, docopt 18:08:08 INFO - Running setup.py install for blobuploader 18:08:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:08:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:08:08 INFO - Running setup.py install for requests 18:08:08 INFO - Running setup.py install for docopt 18:08:08 INFO - Successfully installed blobuploader requests docopt 18:08:08 INFO - Cleaning up... 18:08:08 INFO - Return code: 0 18:08:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:08:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:08:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:08 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 0x7f2afcca0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e2290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574850>, '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 0x14e0330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e07c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', '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 18:08:08 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 18:08:08 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 18:08:08 INFO - Using env: {'DISPLAY': ':0', 18:08:08 INFO - 'HOME': '/home/cltbld', 18:08:08 INFO - 'LANG': 'en_US.UTF-8', 18:08:08 INFO - 'LANGUAGE': 'en_US:en', 18:08:08 INFO - 'LOGNAME': 'cltbld', 18:08:08 INFO - 'MAIL': '/var/mail/cltbld', 18:08:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:08 INFO - 'MOZ_NO_REMOTE': '1', 18:08:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:08 INFO - 'NO_EM_RESTART': '1', 18:08:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:08:08 INFO - 'PWD': '/builds/slave/test-pgo', 18:08:08 INFO - 'SHELL': '/bin/bash', 18:08:08 INFO - 'SHLVL': '1', 18:08:08 INFO - 'TERM': 'linux', 18:08:08 INFO - 'TMOUT': '86400', 18:08:08 INFO - 'USER': 'cltbld', 18:08:08 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', 18:08:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:08 INFO - '_': '/tools/buildbot/bin/python'} 18:08:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:08:09 INFO - Running setup.py (path:/tmp/pip-zgqbBn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:08:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:08:09 INFO - Running setup.py (path:/tmp/pip-1HLNj6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:08:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:08:09 INFO - Running setup.py (path:/tmp/pip-UCbc6X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:08:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:08:09 INFO - Running setup.py (path:/tmp/pip-ex542K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:08:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:08:09 INFO - Running setup.py (path:/tmp/pip-nlvdBR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:08:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:08:09 INFO - Running setup.py (path:/tmp/pip-cOHXxO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:08:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:08:09 INFO - Running setup.py (path:/tmp/pip-ZSvLII-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:08:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:08:09 INFO - Running setup.py (path:/tmp/pip-vpw9CZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:08:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:08:09 INFO - Running setup.py (path:/tmp/pip-FM0ogT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:08:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:08:09 INFO - Running setup.py (path:/tmp/pip-px5pMQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:08:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:08:09 INFO - Running setup.py (path:/tmp/pip-qAqs43-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:08:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:08:09 INFO - Running setup.py (path:/tmp/pip-pxGbC7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:08:10 INFO - Running setup.py (path:/tmp/pip-gYBhLB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:08:10 INFO - Running setup.py (path:/tmp/pip-QPpmPv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:08:10 INFO - Running setup.py (path:/tmp/pip-ssiKUd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:08:10 INFO - Running setup.py (path:/tmp/pip-66sRUI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:08:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:08:10 INFO - Running setup.py (path:/tmp/pip-QHDb5c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:08:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:08:10 INFO - Running setup.py install for manifestparser 18:08:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:08:10 INFO - Running setup.py install for mozcrash 18:08:10 INFO - Running setup.py install for mozdebug 18:08:10 INFO - Running setup.py install for mozdevice 18:08:10 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:08:10 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:08:10 INFO - Running setup.py install for mozfile 18:08:10 INFO - Running setup.py install for mozhttpd 18:08:10 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:08:11 INFO - Running setup.py install for mozinfo 18:08:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:08:11 INFO - Running setup.py install for mozInstall 18:08:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:08:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:08:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:08:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:08:11 INFO - Running setup.py install for mozleak 18:08:11 INFO - Running setup.py install for mozlog 18:08:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:08:11 INFO - Running setup.py install for moznetwork 18:08:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:08:11 INFO - Running setup.py install for mozprocess 18:08:11 INFO - Running setup.py install for mozprofile 18:08:11 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:08:11 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:08:11 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:08:11 INFO - Running setup.py install for mozrunner 18:08:11 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:08:11 INFO - Running setup.py install for mozscreenshot 18:08:11 INFO - Running setup.py install for moztest 18:08:12 INFO - Running setup.py install for mozversion 18:08:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:08:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:08:12 INFO - Cleaning up... 18:08:12 INFO - Return code: 0 18:08:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:08:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:08:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:12 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f2afcca0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e2290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574850>, '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 0x14e0330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e07c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', '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 18:08:12 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 18:08:12 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 18:08:12 INFO - Using env: {'DISPLAY': ':0', 18:08:12 INFO - 'HOME': '/home/cltbld', 18:08:12 INFO - 'LANG': 'en_US.UTF-8', 18:08:12 INFO - 'LANGUAGE': 'en_US:en', 18:08:12 INFO - 'LOGNAME': 'cltbld', 18:08:12 INFO - 'MAIL': '/var/mail/cltbld', 18:08:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:12 INFO - 'MOZ_NO_REMOTE': '1', 18:08:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:12 INFO - 'NO_EM_RESTART': '1', 18:08:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:08:12 INFO - 'PWD': '/builds/slave/test-pgo', 18:08:12 INFO - 'SHELL': '/bin/bash', 18:08:12 INFO - 'SHLVL': '1', 18:08:12 INFO - 'TERM': 'linux', 18:08:12 INFO - 'TMOUT': '86400', 18:08:12 INFO - 'USER': 'cltbld', 18:08:12 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', 18:08:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:12 INFO - '_': '/tools/buildbot/bin/python'} 18:08:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:08:12 INFO - Running setup.py (path:/tmp/pip-IkrvDp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:08:12 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)) 18:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:08:12 INFO - Running setup.py (path:/tmp/pip-YiB8lw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:08:12 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)) 18:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:08:12 INFO - Running setup.py (path:/tmp/pip-qjTqCz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:08:12 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)) 18:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:08:12 INFO - Running setup.py (path:/tmp/pip-YHPbge-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:08:12 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)) 18:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:08:12 INFO - Running setup.py (path:/tmp/pip-yOlpEu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:08:12 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)) 18:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:08:12 INFO - Running setup.py (path:/tmp/pip-2k1jDb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:08:12 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)) 18:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:08:12 INFO - Running setup.py (path:/tmp/pip-ex9Go5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:08:12 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)) 18:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:08:12 INFO - Running setup.py (path:/tmp/pip-TWEuXR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:08:12 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)) 18:08:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:08:12 INFO - Running setup.py (path:/tmp/pip-8MmWEj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:08:13 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)) 18:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:08:13 INFO - Running setup.py (path:/tmp/pip-lCIjN_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:08:13 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)) 18:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:08:13 INFO - Running setup.py (path:/tmp/pip-RlWZiK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:08:13 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)) 18:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:08:13 INFO - Running setup.py (path:/tmp/pip-hsRHHE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:08:13 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)) 18:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:08:13 INFO - Running setup.py (path:/tmp/pip-vsC0y8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:08:13 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)) 18:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:08:13 INFO - Running setup.py (path:/tmp/pip-_zCRAK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:08:13 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)) 18:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:08:13 INFO - Running setup.py (path:/tmp/pip-F7bnkV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:08:13 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)) 18:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:08:13 INFO - Running setup.py (path:/tmp/pip-z04fOA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:08:13 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)) 18:08:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:08:13 INFO - Running setup.py (path:/tmp/pip-ZwP4Sq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:08:13 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)) 18:08:13 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)) 18:08:13 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)) 18:08:13 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)) 18:08:13 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)) 18:08:13 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)) 18:08:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:08:13 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 18:08:13 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 18:08:13 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 18:08:13 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 18:08:13 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 18:08:13 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 18:08:15 INFO - Downloading blessings-1.6.tar.gz 18:08:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:08:15 INFO - Installing collected packages: blessings 18:08:15 INFO - Running setup.py install for blessings 18:08:15 INFO - Successfully installed blessings 18:08:15 INFO - Cleaning up... 18:08:15 INFO - Return code: 0 18:08:15 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:08:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:08:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:08:15 INFO - Reading from file tmpfile_stdout 18:08:15 INFO - Current package versions: 18:08:15 INFO - argparse == 1.2.1 18:08:15 INFO - blessings == 1.6 18:08:15 INFO - blobuploader == 1.2.4 18:08:15 INFO - docopt == 0.6.1 18:08:15 INFO - manifestparser == 1.1 18:08:15 INFO - mozInstall == 1.12 18:08:15 INFO - mozcrash == 0.16 18:08:15 INFO - mozdebug == 0.1 18:08:15 INFO - mozdevice == 0.48 18:08:15 INFO - mozfile == 1.2 18:08:15 INFO - mozhttpd == 0.7 18:08:15 INFO - mozinfo == 0.9 18:08:15 INFO - mozleak == 0.1 18:08:15 INFO - mozlog == 3.1 18:08:15 INFO - moznetwork == 0.27 18:08:15 INFO - mozprocess == 0.22 18:08:15 INFO - mozprofile == 0.28 18:08:15 INFO - mozrunner == 6.11 18:08:15 INFO - mozscreenshot == 0.1 18:08:15 INFO - mozsystemmonitor == 0.0 18:08:15 INFO - moztest == 0.7 18:08:15 INFO - mozversion == 1.4 18:08:15 INFO - psutil == 3.1.1 18:08:15 INFO - requests == 1.2.3 18:08:15 INFO - wsgiref == 0.1.2 18:08:15 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:08:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:08:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:15 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 0x7f2afcca0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e2290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574850>, '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 0x14e0330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e07c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', '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 18:08:15 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 18:08:15 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 18:08:15 INFO - Using env: {'DISPLAY': ':0', 18:08:15 INFO - 'HOME': '/home/cltbld', 18:08:15 INFO - 'LANG': 'en_US.UTF-8', 18:08:15 INFO - 'LANGUAGE': 'en_US:en', 18:08:15 INFO - 'LOGNAME': 'cltbld', 18:08:15 INFO - 'MAIL': '/var/mail/cltbld', 18:08:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:15 INFO - 'MOZ_NO_REMOTE': '1', 18:08:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:15 INFO - 'NO_EM_RESTART': '1', 18:08:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:08:15 INFO - 'PWD': '/builds/slave/test-pgo', 18:08:15 INFO - 'SHELL': '/bin/bash', 18:08:15 INFO - 'SHLVL': '1', 18:08:15 INFO - 'TERM': 'linux', 18:08:15 INFO - 'TMOUT': '86400', 18:08:15 INFO - 'USER': 'cltbld', 18:08:15 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', 18:08:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:15 INFO - '_': '/tools/buildbot/bin/python'} 18:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:16 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)) 18:08:16 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)) 18:08:16 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)) 18:08:16 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)) 18:08:16 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)) 18:08:16 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)) 18:08:16 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)) 18:08:16 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)) 18:08:16 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)) 18:08:16 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)) 18:08:16 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)) 18:08:16 INFO - Cleaning up... 18:08:16 INFO - Return code: 0 18:08:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:08: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')]} 18:08:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08: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')]} 18:08:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:16 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 0x7f2afcca0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e2290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574850>, '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 0x14e0330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e07c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', '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 18:08:16 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 18:08:16 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 18:08:16 INFO - Using env: {'DISPLAY': ':0', 18:08:16 INFO - 'HOME': '/home/cltbld', 18:08:16 INFO - 'LANG': 'en_US.UTF-8', 18:08:16 INFO - 'LANGUAGE': 'en_US:en', 18:08:16 INFO - 'LOGNAME': 'cltbld', 18:08:16 INFO - 'MAIL': '/var/mail/cltbld', 18:08:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:16 INFO - 'MOZ_NO_REMOTE': '1', 18:08:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:16 INFO - 'NO_EM_RESTART': '1', 18:08:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:08:16 INFO - 'PWD': '/builds/slave/test-pgo', 18:08:16 INFO - 'SHELL': '/bin/bash', 18:08:16 INFO - 'SHLVL': '1', 18:08:16 INFO - 'TERM': 'linux', 18:08:16 INFO - 'TMOUT': '86400', 18:08:16 INFO - 'USER': 'cltbld', 18:08:16 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', 18:08:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:16 INFO - '_': '/tools/buildbot/bin/python'} 18:08:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:16 INFO - Downloading/unpacking jsonschema 18:08:16 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 18:08:16 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 18:08:16 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 18:08:16 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 18:08:16 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 18:08:16 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 18:08:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:08:18 INFO - Downloading/unpacking functools32 (from jsonschema) 18:08:18 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 18:08:18 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 18:08:18 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 18:08:18 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 18:08:18 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 18:08:18 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 18:08:18 INFO - Downloading functools32-3.2.3-2.tar.gz 18:08:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:08:18 INFO - warning: no files found matching '*.txt' 18:08:18 INFO - no previously-included directories found matching 'build' 18:08:18 INFO - no previously-included directories found matching 'dist' 18:08:18 INFO - no previously-included directories found matching '.git*' 18:08:18 INFO - Installing collected packages: jsonschema, functools32 18:08:18 INFO - Running setup.py install for functools32 18:08:18 INFO - warning: no files found matching '*.txt' 18:08:18 INFO - no previously-included directories found matching 'build' 18:08:18 INFO - no previously-included directories found matching 'dist' 18:08:18 INFO - no previously-included directories found matching '.git*' 18:08:18 INFO - Successfully installed jsonschema functools32 18:08:18 INFO - Cleaning up... 18:08:18 INFO - Return code: 0 18:08:18 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:08: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')]} 18:08:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08: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')]} 18:08:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:18 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 0x7f2afcca0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14138a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14e2290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574850>, '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 0x14e0330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e07c0>, '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': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', '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 18:08:18 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 18:08:18 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 18:08:18 INFO - Using env: {'DISPLAY': ':0', 18:08:18 INFO - 'HOME': '/home/cltbld', 18:08:18 INFO - 'LANG': 'en_US.UTF-8', 18:08:18 INFO - 'LANGUAGE': 'en_US:en', 18:08:18 INFO - 'LOGNAME': 'cltbld', 18:08:18 INFO - 'MAIL': '/var/mail/cltbld', 18:08:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:18 INFO - 'MOZ_NO_REMOTE': '1', 18:08:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:18 INFO - 'NO_EM_RESTART': '1', 18:08:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:08:18 INFO - 'PWD': '/builds/slave/test-pgo', 18:08:18 INFO - 'SHELL': '/bin/bash', 18:08:18 INFO - 'SHLVL': '1', 18:08:18 INFO - 'TERM': 'linux', 18:08:18 INFO - 'TMOUT': '86400', 18:08:18 INFO - 'USER': 'cltbld', 18:08:18 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', 18:08:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:18 INFO - '_': '/tools/buildbot/bin/python'} 18:08:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:18 INFO - Downloading/unpacking flake8 18:08:18 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 18:08:18 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 18:08:18 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 18:08:18 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 18:08:18 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 18:08:18 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 18:08:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:08:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:08:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:08:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:08:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:08:21 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 18:08:21 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 18:08:21 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 18:08:21 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 18:08:21 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 18:08:21 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 18:08:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:08:21 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 18:08:21 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 18:08:21 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 18:08:21 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 18:08:21 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 18:08:21 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 18:08:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:08:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:08:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:08:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:08:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:08:21 INFO - no previously-included directories found matching 'docs/_build' 18:08:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:08:21 INFO - Running setup.py install for pep8 18:08:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:08:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:08:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:08:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:08:21 INFO - no previously-included directories found matching 'docs/_build' 18:08:21 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:08:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:08:21 INFO - Cleaning up... 18:08:21 INFO - Return code: 0 18:08:21 INFO - Running post-action listener: _resource_record_post_action 18:08:21 INFO - Running post-action listener: _start_resource_monitoring 18:08:21 INFO - Starting resource monitoring. 18:08:21 INFO - ##### 18:08:21 INFO - ##### Running install step. 18:08:21 INFO - ##### 18:08:21 INFO - Running pre-action listener: _resource_record_pre_action 18:08:21 INFO - Running main action method: install 18:08:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:08:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:08:21 INFO - Reading from file tmpfile_stdout 18:08:22 INFO - Detecting whether we're running mozinstall >=1.0... 18:08:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:08:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:08:22 INFO - Reading from file tmpfile_stdout 18:08:22 INFO - Output received: 18:08:22 INFO - Usage: mozinstall [options] installer 18:08:22 INFO - Options: 18:08:22 INFO - -h, --help show this help message and exit 18:08:22 INFO - -d DEST, --destination=DEST 18:08:22 INFO - Directory to install application into. [default: 18:08:22 INFO - "/builds/slave/test-pgo"] 18:08:22 INFO - --app=APP Application being installed. [default: firefox] 18:08:22 INFO - mkdir: /builds/slave/test-pgo/build/application 18:08:22 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'] 18:08:22 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 18:08:34 INFO - Reading from file tmpfile_stdout 18:08:34 INFO - Output received: 18:08:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:08:34 INFO - Running post-action listener: _resource_record_post_action 18:08:34 INFO - ##### 18:08:34 INFO - ##### Running run-tests step. 18:08:34 INFO - ##### 18:08:34 INFO - Running pre-action listener: _resource_record_pre_action 18:08:34 INFO - Running main action method: run_tests 18:08:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:08:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:08:34 INFO - Python 2.7.3 18:08:34 INFO - Return code: 0 18:08:34 INFO - grabbing minidump binary from tooltool 18:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:08:34 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1574850>, '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 0x14e0330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e07c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:08:34 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 18:08:34 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:08:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:08:34 INFO - Return code: 0 18:08:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:08:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:08:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:08:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:08:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:08:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:08:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:08:35 INFO - Return code: 0 18:08:35 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/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 18:08:35 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/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 18:08:35 INFO - Using env: {'DISPLAY': ':0', 18:08:35 INFO - 'HOME': '/home/cltbld', 18:08:35 INFO - 'LANG': 'en_US.UTF-8', 18:08:35 INFO - 'LANGUAGE': 'en_US:en', 18:08:35 INFO - 'LOGNAME': 'cltbld', 18:08:35 INFO - 'MAIL': '/var/mail/cltbld', 18:08:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:08:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:35 INFO - 'MOZ_NO_REMOTE': '1', 18:08:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:08:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:35 INFO - 'NO_EM_RESTART': '1', 18:08:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:08:35 INFO - 'PWD': '/builds/slave/test-pgo', 18:08:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:08:35 INFO - 'SHELL': '/bin/bash', 18:08:35 INFO - 'SHLVL': '1', 18:08:35 INFO - 'TERM': 'linux', 18:08:35 INFO - 'TMOUT': '86400', 18:08:35 INFO - 'USER': 'cltbld', 18:08:35 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742', 18:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:35 INFO - '_': '/tools/buildbot/bin/python'} 18:08:35 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/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 18:08:35 INFO - mozversion application_buildid: 20160324152934 18:08:35 INFO - mozversion application_changeset: b2bc679410410214e1fd9953deb1439182332aa5 18:08:35 INFO - mozversion application_display_name: Firefox 18:08:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:08:35 INFO - mozversion application_name: Firefox 18:08:35 INFO - mozversion application_remotingname: firefox 18:08:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 18:08:35 INFO - mozversion application_vendor: Mozilla 18:08:35 INFO - mozversion application_version: 46.0 18:08:35 INFO - mozversion platform_buildid: 20160324152934 18:08:35 INFO - mozversion platform_changeset: b2bc679410410214e1fd9953deb1439182332aa5 18:08:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 18:08:35 INFO - mozversion platform_version: 46.0 18:08:35 INFO - using testdate: 1458868115 18:08:35 INFO - actual date: 1458868115 18:08:36 INFO - starting webserver on 'localhost:40316' 18:08:36 INFO - SUITE-START | Running 3 tests 18:08:36 INFO - TEST-START | dromaeo_css 18:08:36 INFO - operating with platform_type : linux_ 18:08:36 INFO - Initialising browser for dromaeo_css test... 18:08:36 INFO - TEST-INFO | started process 1420 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpApIhfT/profile http://localhost:40316/getInfo.html) 18:08:40 INFO - PROCESS | 1420 | __metrics Screen width/height:1600/1200 18:08:40 INFO - PROCESS | 1420 | colorDepth:24 18:08:40 INFO - PROCESS | 1420 | Browser inner width/height: 1024/697 18:08:40 INFO - PROCESS | 1420 | __metrics 18:08:40 INFO - PROCESS | 1420 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:08:41 INFO - TEST-INFO | 1420: exit 0 18:08:41 INFO - Browser initialized. 18:08:41 INFO - Running cycle 1/1 for dromaeo_css test... 18:08:41 INFO - TEST-INFO | started process 1507 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpApIhfT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:08:53 INFO - PROCESS | 1507 | RSS: Main: 136888320 18:08:53 INFO - PROCESS | 1507 | 18:09:44 INFO - PROCESS | 1507 | 1458868184817 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] 18:11:51 INFO - PROCESS | 1507 | Cycle 1(1): loaded http://localhost:40316/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40316/tests/dromaeo/cssquery-ext.html) 18:11:52 INFO - PROCESS | 1507 | RSS: Main: 210382848 18:11:52 INFO - PROCESS | 1507 | 18:14:54 INFO - PROCESS | 1507 | Cycle 1(1): loaded http://localhost:40316/tests/dromaeo/cssquery-ext.html (next: http://localhost:40316/tests/dromaeo/cssquery-jquery.html) 18:14:55 INFO - PROCESS | 1507 | RSS: Main: 225759232 18:14:55 INFO - PROCESS | 1507 | 18:17:57 INFO - PROCESS | 1507 | Cycle 1(1): loaded http://localhost:40316/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40316/tests/dromaeo/cssquery-mootools.html) 18:17:57 INFO - PROCESS | 1507 | RSS: Main: 232157184 18:17:57 INFO - PROCESS | 1507 | 18:20:59 INFO - PROCESS | 1507 | Cycle 1(1): loaded http://localhost:40316/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40316/tests/dromaeo/cssquery-prototype.html) 18:21:00 INFO - PROCESS | 1507 | RSS: Main: 202293248 18:21:00 INFO - PROCESS | 1507 | 18:24:02 INFO - PROCESS | 1507 | Cycle 1(1): loaded http://localhost:40316/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40316/tests/dromaeo/cssquery-yui.html) 18:24:03 INFO - PROCESS | 1507 | RSS: Main: 206241792 18:24:03 INFO - PROCESS | 1507 | 18:27:05 INFO - PROCESS | 1507 | Cycle 1(1): loaded http://localhost:40316/tests/dromaeo/cssquery-yui.html (next: http://localhost:40316/tests/dromaeo/cssquery-dojo.html) 18:27:05 INFO - PROCESS | 1507 | RSS: Main: 249729024 18:27:05 INFO - PROCESS | 1507 | 18:27:05 INFO - PROCESS | 1507 | __start_tp_report 18:27:05 INFO - PROCESS | 1507 | _x_x_mozilla_page_load 18:27:05 INFO - PROCESS | 1507 | _x_x_mozilla_page_load_details 18:27:05 INFO - PROCESS | 1507 | |i|pagename|runs| 18:27:05 INFO - PROCESS | 1507 | |0;dojo.html;3149.3228955774503;3153.7950033247853;3175.3966746318197;3186.7131958123764;3207.1501052221165;5150.227465880111;5174.120399532079;5180.404253510847;5184.818531351399;5196.92204616931;5141;5183.092958732216;5200.713960732158;5207.6875387476775;5237.47625237476;4671.649626278026;4726.952730472694;4735.73953432561;4775.3075804008395;4797.2324428091515;4824.927626085611;4844.757762111898;4868.391451068616;4881.926771098419;4882.389701287339;4835.032993401333;4839.225723884179;4868.513148685139;4881.633877459187;4886.169351210303;4747.45404278509;4782.880427989293;4827.8310259140935;4847.12751704693;4863.8784030399165;4740.715557066587;4768.260919557474;4774.379330686988;4781.832635857728;4807.807687692488;4956.430010548797;5036.496350364971;5051.621128415383;5060.038592667418;5147.150720131174;5536.889262214733;5561.388247292794;5592.748326325325;5606.831795046155;5626.127950167731;5535.086710692731;5587.329520457531;5596.748146333425;5600.0759874620635;5611.494965453129;5080.644354895159;5215.6609820361555;5234;5239.711815850127;5249.895002099936;5659.886802263932;5681.0910254359105;5683.460071293221;5700.087985922232;5701.4298570142655;5477.233187353773;5483.561315094783;5484.314460692413;5484.341878974548;5487.341519017744;5472.753726082336;5540.36285827135;5552.611317207757;5581.190727344512;5631.774729010794;5516.365617953987;5535.6955367455175;5539.169124631338;5544.445555444423;5549.528290095306;5552.333719953632;5566.276384070045;5566.693831839207;5579.553635709133;5580.135079062752;4270.658347332206;4320.611144996966;4324.286492728727;4357.063231405263;4382.737035777864;3850.4609354690365;3858.8456461741775;3859.1124041470057;3863.343231650626;3883.2427676603356;5087.364079490064;5222.738863056832;5231.71225582589;5233.973830130825;5259.631825772236;5531.612787104864;5549.223108764776;5619.494245517923;5622.24099746529;5638.323401191801;5136.049830781318;5167.302414174113;5167.586593072545;5169.172932330885;5201.193814958688;4710.52894710533;4743.241081426955;4781.2350023996;4789.44921334051;4792.880177995578;5624.21261023457;5675.914861277084;5696;5696.287964004499;5732.111522713986;5599.32808063035;5608.355039170385;5622.6064175508955;5623.184638227516;5629.7748090077575;5637.069883469182;5688.857778555569;5724.57065720081;5776.595638305278;5782.855428614318;5562.805301814417;5567.025770490067;5568.526675232651;5569.582281328998;5578.051731205624;5603.691796951207;5605.24329215567;5606.215129881738;5607.719614019365;5615.775368985195;5315.946840531546;5393.6763794172475;5469.644473109235;5526;5551.22282880389;5467.234587157881;5496.065668836387;5499.092649712753;5499.835004949858;5501.779928802963;5349.518543331119;5410.269613602113;5414.133738601805;5419.376771671308;5450.727463626724;5398.325209348832;5417.729113544228;5476.91784623223;5496.31296087989;5550.111982082847;5230.476952304739;5270.868228294324;5271;5302.3637163540625;5328.920066199088 18:27:05 INFO - PROCESS | 1507 | |1;ext.html;560.6888177061729;560.7168379968116;579.7651950959863;581.2937281203338;586.6128355285512;30994.2251443714;31558.526622100628;31733.841330793344;38455.42316865242;38835.80582097093;42668;42887.14225715484;43042.35436468456;43042.35436468456;43113.78443107788;8701.216890479856;8895.154960278764;8913.643454261823;8916.331275154356;8916.955415222916;8591.785205369884;8737.301015918743;8752.781180470507;8787.472751634923;8788.209061184492;8971.147740964598;9031.051739567349;9043.728688139367;9055.003949565542;9063.365564410495;8906.51014194219;9010.729678109667;9023.593938272761;9025.593848276778;9026.097390260988;8788.780280492974;8929.687460938901;8931.910680893174;8935.865962010575;8936;41761.95595110116;42522.57477425217;42564.787176063925;42576.3613545794;42601.78699106516;3555.1467647764607;3559.857605695769;3572.3212589607892;3575.3921833288405;3575.8212089395424;31095.68904310973;31170.064898053093;31413.8429307852;31695.683043169734;32750.508742368882;3920.8039598019986;3991.8004099794894;4036.576159503239;4077.8980525486804;4093.3655283431117;293029;293241;293870;294372;294833;57367.42632573621;58287.70856145692;61896.28622282678;62532;62981.37018629755;61730.38269617246;62071.37928620746;62213.68893155505;62463;62482;17864.196111175028;18157.7276340855;18168.091595420177;18173;18180.36368727088;12403.503859845505;12435.564755233523;12496.187747796364;12597.307148106942;12645.114841961158;20127.496812579804;20557.794422055886;20602.27892023772;20602.27892023772;20608.793912060988;7532.54804711719;7769.53382797034;7786.571738554434;7798.376129909707;7830.295273425305;1044.8746150461993;1075.8440026196158;1081.4754843900703;1092.1590375411047;1147.1912301827192;30434.239144021132;30537;30833;31354.372912542076;31916.361672766878;1092.2136062035322;1155.757290968889;1160.8665003524534;1182.9585964491203;1211.19455562052;12455.93772031134;14592.562223133324;15047.437954324798;15936.521904342888;16111.677766444605;277125;280112;280339;281567;281925;53607.73196134072;53783.50407223518;53816;53824.73087634537;53929.46070539323;1328.16325714801;1335.8530561638213;1439.6760728835927;1464.985350146506;1479.659678274003;26619.60070598904;26841;26886.731132688423;27207.455850882474;30081.247968800955;47214;47469.28796068131;47582;47602.52397475981;47614.76192619015;200975;333641;337174;337964;338768;31563.84218078895;32122;32268.19329516781;32300;32342.83828580842;43740;44268.33597495976;44784.552154478035;45471.54528454673;45547.089058217985;35994.82002590075;36573;37257.254854903294;37639;40689.38965915454;39783.60216397799;40540.1891962165;40636.18727625372;41191.588084118775;41374.58625413707;40273.597264028154;40387.394189087776;40421.1915761689;40753.38869916894;40842;36308.9426865232;36522.269554608225;36697;36920.81539592392;37283.81358093192;27504.44991100207;27515.31211719723;27575.43344692934;27663;27670 18:27:05 INFO - PROCESS | 1507 | |2;jquery.html;390.9354956432188;392.621120618603;394.15650507913074;395.25494442975;399.1816775609999;14328.570142895729;15545.844541554581;16232.350705971761;18117.547061323472;18172.18225179867;11763.470643821027;11997.700057498545;12011.519539218443;13926.79109813351;17915.552111197227;5081.872953176182;5268.394134674523;5272.103742363788;5280.075986702331;5280.1815718563685;4030.2141082488924;4175.331946888498;5157.149070403379;5480.232767412565;5676.432356764311;5354.330708661418;5669.574781891354;5688.60179787415;5693.259876216086;5707.828765137032;5424.240606315079;5456.508914197741;5466.426025267349;5486.643368181076;5500.367457742371;5561.110222364402;5613.859653508654;5615.80344687938;5618.353889302742;5626;13003.349832508336;13230.735385292337;13244.139130956457;13246;13682.31588420575;2157.6871353653632;2217.102073660154;2243.697100891375;2249.0778780699998;2257.932262032142;10870.945645271722;13324.533641322603;13374.665633359147;13677.042607017513;13789.51736689211;1934.516370907273;1976.2885361269932;1980.722698822166;2073.844461665366;2074.222166687492;62278;62689.37310626881;63974.68012659954;64874.67562662157;65160.67419662919;10502.894971050191;11006.229563930448;11072.501737421835;11134.610288639858;11143.219974601861;14544.927275363767;14644.341004654816;14647.707045859237;14683.48607798722;14689.485867994568;8106.351491880753;8144.226298501633;8519.48883067018;8540.316774658013;8594.699185528476;8301.086880443147;8334.249917507454;8356.916430835736;8425.873611895826;8431.662733490715;4362.716423432466;4694.413198350207;4699.107169637827;4718.339432479455;4803.063402636452;1736.1143837359361;1886.4340697790608;1919.5297152197802;1920.3278852401827;1941.3496478679517;461.4831388844516;462.19577934393914;464.5261832930392;1016.425719468498;1051.2115913065202;9951.601935922627;10960;11143.888561114285;11234.269772464764;11508.367039812723;484.2566660176612;493.2133247470351;495.46242327074805;499.07670809003054;513.2378418049194;9758.316917815826;10259.230557708202;10315.071643551966;10338.896611033793;10349.223808214414;629420.6760695688;632857;645395;657249;666924;78789.60605196937;80256;80788.59605701934;81128.59435702783;85355.57322213349;1224.381687247934;1244.4897591987242;1250.9687257818628;1266.1580049267318;1268.0806415348798;14950.551483455514;15933.760993585338;16189.352425902833;16217.918910405373;16263;31789.20526986844;31990.52014219742;33018.33963320768;33378.16554586155;33636.1590960228;38766.4185037219;40282.597174027884;40619.390709138796;40919;42742.57257427386;7792.376609871083;8025.8796118059445;8060.234277743605;8069.556174410463;8087.595620218848;10299.845502317321;11511.597094101666;11714.891319562219;11784.410779461165;11914.52341906314;9031.187193152648;9936.701898943043;10001.699949001542;10018.298719089593;10064.245181611263;10032.799344012932;10242.897571024194;10441.112505437122;10688.83966740484;10805.945970270099;7691.50005249657;9646.469444180637;10046.648367307109;10067;10458.790824183627;7742.690292388242;7836.255555722198;7856.371490280878;7858.253465920729;7889.447738658238;9226.433507936621;9754.658586949423;9874.061964113398;10215.387076775418;10243.487825608541 18:27:05 INFO - PROCESS | 1507 | |3;mootools.html;1372.4647387518876;1521.513115802943;1561.828198898121;1772.220223101835;1891.3663922585934;6849.7602583909575;7194.8920766188485;7325.487215894889;7325.743598974037;7329.157146928112;7266.672999715012;7349.669264883079;7407.185209626937;7414.1473730521;7417.221191774867;2291.8395712300103;2315.050829160045;2316.5945959457113;2317.478567322356;2349.259983105325;2265.9433514162197;2306.6655334976417;2381.285614315707;2384.2727967969763;2390.6175011998084;2214.8228141748623;2235.251190851067;2237.7202849643795;2262.875541845198;2265.0373591223665;2299.9195028173935;2356.1400088967575;2358.5990381635165;2364.2670772060715;2366.881655917206;2304.101400453824;2311.8266130040315;2318.455163036685;2325.058351367682;2325.976740232593;6590.373914478117;6722.092517510123;7579.583122928237;7612.7716168515035;7629.7329593463965;4322.459692538433;4564.497905230422;4678.485366609671;4681.414823147106;4682.836100736458;2971.4948458762065;2999.6100506934176;3002.519596864513;3009.0972708187674;3167.0182243504587;1024.6977141743203;1031.6698656429946;1038.2109596706482;1070.8875568065396;1071.23406764164;9942.602295908155;10057.597696092147;10061.748456288578;10064.798704025952;10193.337433066752;4288.228118938621;4294.570542945743;4310.051788606502;4346.7609281489185;4364.607185353333;9138.497382644018;9141.451512909247;9149.313801464783;9156.404833685789;9173.908260917438;4836.709797412166;4850.078485087822;4850.902981940341;4850.95149048512;4854.296127061627;4418.756968366771;4420.756858372756;4422.115576884636;4429.7785110744335;4446.044100518404;3641.708663306929;3694.5751238607368;3715.7398982071536;3724.5344331958504;3787.696984241254;1200.0459634590522;1202.753435545711;1208.6313674329238;1212.9757404851853;1213.3751118174148;1141.2125633312987;1150.0626989003936;1176.847009888726;1183.2900259844025;1200.429795846983;6919.7232110715;6956.304369563003;7043.506954513237;7116.430685545144;7136.3220494052985;1188.2692144331347;1188.5780547905542;1191.6603767926272;1198.8730593242324;1205.445495072259;5264.552513036435;5697.259356283656;5761.366249712528;5763.193152958589;5764.827055188351;8246.917530824734;8324.6670133194;8467.364947628952;8501.61742721579;8514.829703405898;8417.158284171657;8425.199606037417;8426.452280601741;8448.197421244971;8539.914600854036;7133.393661538724;7265.455090868206;7273.89089163663;7275.745348912763;7290.3438690518105;6853.7943861684225;7177.3899218567;7222.205557388788;7235.855282894207;7236.38490728294;7814.21857814214;7941.920580794349;7952.284294413531;8059.43583949118;8074.273315401642;7952.165022672768;8204.671813127647;8230.382721295808;8238.670453181805;8245.051819040647;6664.833379165366;6717.059611654275;6739.123913891162;6774.525783195326;6782.626955517297;7259.165196002527;7302.488825782144;7305.2329505403295;7332.670029848777;7337.559746415232;6750.426213771884;6895.4138898194215;7013.964930175316;7143.607101609461;7143.9285607143265;6691.498137639599;6797.346501072491;6865.382115609419;6894.655267236719;6896.206936202401;6585.440237579668;6714.6642667865435;6765.458763298826;6776;6813.8977915330315;6289.779857704958;6351.71417286214;6351.841203969753;6354.078658594385;6354.301026886947;6326.240851097898;6390.48876089921;6420.7431702731365;6426.036094585663;6431.035344698333 18:27:05 INFO - PROCESS | 1507 | |4;prototype.html;349.42345130534613;352.3516729218239;353.9256756081223;356.6237619311625;358.9533360663115;6058.5456090793205;6069.332373438918;6084.330723620409;6086.8478288042825;6096.085587161928;5790.218320526727;5814.912776308359;5904.232449781533;5939.762409503614;5949.732262048207;4596.333531637911;4602.424696912894;4624.630029597624;4628.976855115719;4665.370175026362;4516.2322405191035;4645.9303110453375;4673.953260467386;4674.135284972291;4677.508861569538;4493.101379724052;4567.840125595605;4612.769361531927;4617.676762626617;4620.099080679269;4584.633229341644;4599.356090147348;4609.03210325832;4612.654050946176;4621;4107.732997355162;4108.712390132692;4111.362738775495;4112.753234805921;4122.793860307002;5581.469760372758;5708.40061793514;5714.028615135437;5722.399148089474;5726.198332233491;5398.24424580559;5411.702356370398;5414.377346605152;5423.403425623178;5430.402655707909;6395.104685344056;6424.967875160594;6425.357464253584;6428.485721142298;6439.098526206288;4594.816207351702;4597.494275629678;4605.4933957264675;4608.400907881987;4608.6082682971655;6501.707423165922;6588.4729221662155;6638.070670106189;6641.535092543524;6644.900326495106;4690.15577196108;4692.53074692528;4694.483606803317;4698.859034228979;4700.177468942921;4755.857324280208;4759.952400476021;4762.499937506581;4763.809447622126;4764.404449443819;5409.675419474844;5414.052540805422;5416.458354164631;5416.674999500043;5416.783328666809;6281.654509001957;6411.358864113551;6435.420812126931;6440.935590644127;6441.581297215666;1672.6487437637988;1693.1111166637613;1696.5419336779;1697.9235934382982;1698.3970690404728;1115.55935405516;1135.211028335299;1136.6362763915633;1137.5961533655598;1141.149843366697;6107.572469927151;6116.694165291718;6144.723487443076;6145.108959200891;6146.631202127886;6368.29948705642;6585;6587.538872278895;6592.208934927743;6597.670116494156;6006.489448396847;6090.847728806727;6145.4161854623735;6160.845978850475;6189.071639254148;3488.6162522122545;3533.876314328986;3555.3244883472057;3559.110222444389;3559.2347645256395;6704.161979752531;6795.762148324785;6798.252192258848;6823.078884350549;6825.044493770876;6723.66381680914;6739.966300168468;6776.42400395962;6797.898031529531;6807.897881531781;6795.694193761293;6801.081853949653;6804;6808.2510923798345;6810.080639113657;6469.611823290617;6589.439897608565;6595.175603049619;6595.604263743999;6633.734650613921;6482.513811464065;6501.894677904673;6503.934960650522;6506.707198176188;6528;6803.285655006351;6805.217399999064;6806.319368063352;6813.761518346834;6818;4736.715797052188;4757.524247575215;4767.070421267819;4768.451628062817;4771.093492236464;6423.907935650857;6586.967065164644;6602.438792702482;6606.570572912745;6608.173978252718;6362.713677884413;6398.264199617103;6411.294757576569;6415.871682566416;6422.6467544285515;6354.744065856555;6429.22849258092;6455.386738259858;6457.3865482779065;6467.547271690936;6340.778072767431;6350.618962862243;6355.269144048493;6361.268454127835;6363.236411630634;6463.998080297373;6473.741050357933;6478.5141114415665;6479.1901012373455;6483.7730679425995;6145.477634401126;6292;6303.810885673437;6314.905276420949;6321.96839015802 18:27:05 INFO - PROCESS | 1507 | |5;yui.html;812.7114874219653;823.7034667519696;828.1511450762963;832.1886160993029;841.242881406734;14399.78400323996;14506.492272770442;14706.70586588269;14732.926335368322;15259.313330900108;14469.276536173202;14534.709305813878;14541.709165816677;14544.709105817878;14553.927230363859;753.1790348520112;758.8102974256436;889.1553024626614;906.6735975048977;907.0657223060225;878.1350369885657;893.7988952485704;900.1718419054453;902.715644571961;902.7201567514091;950.1543626172712;953.9570719317647;955.4219697083269;955.7801705607715;955.9378640388353;784.9607519624025;785.6503855784179;787.9369650427981;932.1563984593886;945.078548415293;689.9482538809609;691.1291772366855;701.4984286235315;701.7508784381522;702.5784529282441;14829.110253384832;14904.254787260703;14906.180160091191;14909.7763533546;14925.10449373041;13662.248576328298;13723.45106195751;14012.089214201147;14452.855471445362;14559.490417835324;10455.947720261425;10508.78982420355;10557.260991730582;10571.418571978538;10653.733656658567;3902.2975864344407;3924.803759811998;3937.7834219117935;3942.4086387041884;3943.132510847609;49883.50116498825;50775.49224507782;52839.207411888856;53093.469065309626;53334.19998699984;10832.783344333227;10899.455027248607;11077.335359878272;11119.55521779136;11218.158638102012;19523.414297571097;19551.902240488707;19561.217551298072;19592.314269000515;19619.21523139087;7840.568768717661;7877.606119693993;8095.554744488992;8169.63236654352;8227.917720822836;4354.542773008852;4486.439195100613;4495.21333766596;4521.412216411911;4531.524189960072;3196.4246435641808;3220.0178945421403;3230.789998650127;3234.498652708834;3272.2964562618677;551.6386766667839;564.6358099026105;570.1277046119444;573.6644063222977;587.917691523187;578.5949538607574;612.4824523277823;653.8594202246445;658.5456035335603;662.2020465339255;8578.227959483676;8618.181272779077;8766.736997890073;8833.69082082124;9013.414128081653;533.6104643610187;560.9242752228479;659.1431139518606;663.9767608133692;691.6403470195571;4134.421181034658;4351.804168812411;4369.3227549729845;4385.890352741207;4394.231009573376;55925;56669.71665141648;57768.422315776304;57878;60345;51705.482945170064;52717.736411317695;52889.206661900105;52948.735256323474;53267.46732532625;45646;46006;46158.30762538565;46793.830154247094;47052.5294747055;8283.58582070906;8434.114417986024;8499.065102838558;8548.187922147386;8565.400421970402;34270.14324641904;34473.65526344704;35735.64264357323;37004.074898127765;37554.812225938695;43319.35020974625;43831.78084109559;44074;44506.10987780291;47309.290360645304;11921.701957451132;12116;12556.37218139071;12940.547080852126;12977;13114.803277950648;13222.140560863512;13438.798418023542;13569.864301357255;14018.929905350407;10898;11069.72325691832;11262.83105753398;12006.279623222634;12281;12469.5012199511;12528.373581320715;12583.748325033632;12697.682557936125;12855.742885142057;9512.571934262836;11130;11153.944230278797;11331;11492.253003554742;9784.51077446139;9811.264155188246;9960.701178964642;10175.542100605639;10176.440295783803;9955.452450115023;10091.344062635904;10130.493475326351;10184.287099903231;10208 18:27:05 INFO - PROCESS | 1507 | __end_tp_report 18:27:05 INFO - PROCESS | 1507 | __start_cc_report 18:27:05 INFO - PROCESS | 1507 | _x_x_mozilla_cycle_collect,787 18:27:05 INFO - PROCESS | 1507 | __end_cc_report 18:27:05 INFO - PROCESS | 1507 | __startTimestamp1458869225666__endTimestamp 18:27:05 INFO - PROCESS | 1507 | 18:27:05 INFO - PROCESS | 1507 | ------- Summary: start ------- 18:27:05 INFO - PROCESS | 1507 | Number of tests: 6 18:27:05 INFO - PROCESS | 1507 | 18:27:05 INFO - PROCESS | 1507 | [#0] dojo.html Cycles:165 Average:5184.27 Median:5393.68 stddev:553.93 (10.3%) stddev-sans-first:532.13 18:27:05 INFO - PROCESS | 1507 | Values: 3149.3 3153.8 3175.4 3186.7 3207.2 5150.2 5174.1 5180.4 5184.8 5196.9 5141.0 5183.1 5200.7 5207.7 5237.5 4671.6 4727.0 4735.7 4775.3 4797.2 4824.9 4844.8 4868.4 4881.9 4882.4 4835.0 4839.2 4868.5 4881.6 4886.2 4747.5 4782.9 4827.8 4847.1 4863.9 4740.7 4768.3 4774.4 4781.8 4807.8 4956.4 5036.5 5051.6 5060.0 5147.2 5536.9 5561.4 5592.7 5606.8 5626.1 5535.1 5587.3 5596.7 5600.1 5611.5 5080.6 5215.7 5234.0 5239.7 5249.9 5659.9 5681.1 5683.5 5700.1 5701.4 5477.2 5483.6 5484.3 5484.3 5487.3 5472.8 5540.4 5552.6 5581.2 5631.8 5516.4 5535.7 5539.2 5544.4 5549.5 5552.3 5566.3 5566.7 5579.6 5580.1 4270.7 4320.6 4324.3 4357.1 4382.7 3850.5 3858.8 3859.1 3863.3 3883.2 5087.4 5222.7 5231.7 5234.0 5259.6 5531.6 5549.2 5619.5 5622.2 5638.3 5136.0 5167.3 5167.6 5169.2 5201.2 4710.5 4743.2 4781.2 4789.4 4792.9 5624.2 5675.9 5696.0 5696.3 5732.1 5599.3 5608.4 5622.6 5623.2 5629.8 5637.1 5688.9 5724.6 5776.6 5782.9 5562.8 5567.0 5568.5 5569.6 5578.1 5603.7 5605.2 5606.2 5607.7 5615.8 5315.9 5393.7 5469.6 5526.0 5551.2 5467.2 5496.1 5499.1 5499.8 5501.8 5349.5 5410.3 5414.1 5419.4 5450.7 5398.3 5417.7 5476.9 5496.3 5550.1 5230.5 5270.9 5271.0 5302.4 5328.9 18:27:05 INFO - PROCESS | 1507 | 18:27:05 INFO - PROCESS | 1507 | [#1] ext.html Cycles:180 Average:47440.60 Median:37461.41 stddev:77400.32 (206.6%) stddev-sans-first:77537.41 18:27:05 INFO - PROCESS | 1507 | Values: 560.7 560.7 579.8 581.3 586.6 30994.2 31558.5 31733.8 38455.4 38835.8 42668.0 42887.1 43042.4 43042.4 43113.8 8701.2 8895.2 8913.6 8916.3 8917.0 8591.8 8737.3 8752.8 8787.5 8788.2 8971.1 9031.1 9043.7 9055.0 9063.4 8906.5 9010.7 9023.6 9025.6 9026.1 8788.8 8929.7 8931.9 8935.9 8936.0 41762.0 42522.6 42564.8 42576.4 42601.8 3555.1 3559.9 3572.3 3575.4 3575.8 31095.7 31170.1 31413.8 31695.7 32750.5 3920.8 3991.8 4036.6 4077.9 4093.4 293029.0 293241.0 293870.0 294372.0 294833.0 57367.4 58287.7 61896.3 62532.0 62981.4 61730.4 62071.4 62213.7 62463.0 62482.0 17864.2 18157.7 18168.1 18173.0 18180.4 12403.5 12435.6 12496.2 12597.3 12645.1 20127.5 20557.8 20602.3 20602.3 20608.8 7532.5 7769.5 7786.6 7798.4 7830.3 1044.9 1075.8 1081.5 1092.2 1147.2 30434.2 30537.0 30833.0 31354.4 31916.4 1092.2 1155.8 1160.9 1183.0 1211.2 12455.9 14592.6 15047.4 15936.5 16111.7 277125.0 280112.0 280339.0 281567.0 281925.0 53607.7 53783.5 53816.0 53824.7 53929.5 1328.2 1335.9 1439.7 1465.0 1479.7 26619.6 26841.0 26886.7 27207.5 30081.2 47214.0 47469.3 47582.0 47602.5 47614.8 200975.0 333641.0 337174.0 337964.0 338768.0 31563.8 32122.0 32268.2 32300.0 32342.8 43740.0 44268.3 44784.6 45471.5 45547.1 35994.8 36573.0 37257.3 37639.0 40689.4 39783.6 40540.2 40636.2 41191.6 41374.6 40273.6 40387.4 40421.2 40753.4 40842.0 36308.9 36522.3 36697.0 36920.8 37283.8 27504.4 27515.3 27575.4 27663.0 27670.0 18:27:05 INFO - PROCESS | 1507 | 18:27:05 INFO - PROCESS | 1507 | [#2] jquery.html Cycles:180 Average:30778.15 Median:393.39 stddev:105689.82 (26866.5%) stddev-sans-first:105961.68 18:27:05 INFO - PROCESS | 1507 | Values: 390.9 392.6 394.2 395.3 399.2 14328.6 15545.8 16232.4 18117.5 18172.2 11763.5 11997.7 12011.5 13926.8 17915.6 5081.9 5268.4 5272.1 5280.1 5280.2 4030.2 4175.3 5157.1 5480.2 5676.4 5354.3 5669.6 5688.6 5693.3 5707.8 5424.2 5456.5 5466.4 5486.6 5500.4 5561.1 5613.9 5615.8 5618.4 5626.0 13003.3 13230.7 13244.1 13246.0 13682.3 2157.7 2217.1 2243.7 2249.1 2257.9 10870.9 13324.5 13374.7 13677.0 13789.5 1934.5 1976.3 1980.7 2073.8 2074.2 62278.0 62689.4 63974.7 64874.7 65160.7 10502.9 11006.2 11072.5 11134.6 11143.2 14544.9 14644.3 14647.7 14683.5 14689.5 8106.4 8144.2 8519.5 8540.3 8594.7 8301.1 8334.2 8356.9 8425.9 8431.7 4362.7 4694.4 4699.1 4718.3 4803.1 1736.1 1886.4 1919.5 1920.3 1941.3 461.5 462.2 464.5 1016.4 1051.2 9951.6 10960.0 11143.9 11234.3 11508.4 484.3 493.2 495.5 499.1 513.2 9758.3 10259.2 10315.1 10338.9 10349.2 629420.7 632857.0 645395.0 657249.0 666924.0 78789.6 80256.0 80788.6 81128.6 85355.6 1224.4 1244.5 1251.0 1266.2 1268.1 14950.6 15933.8 16189.4 16217.9 16263.0 31789.2 31990.5 33018.3 33378.2 33636.2 38766.4 40282.6 40619.4 40919.0 42742.6 7792.4 8025.9 8060.2 8069.6 8087.6 10299.8 11511.6 11714.9 11784.4 11914.5 9031.2 9936.7 10001.7 10018.3 10064.2 10032.8 10242.9 10441.1 10688.8 10805.9 7691.5 9646.5 10046.6 10067.0 10458.8 7742.7 7836.3 7856.4 7858.3 7889.4 9226.4 9754.7 9874.1 10215.4 10243.5 18:27:05 INFO - PROCESS | 1507 | 18:27:05 INFO - PROCESS | 1507 | [#3] mootools.html Cycles:180 Average:5310.44 Median:6338.98 stddev:2629.37 (41.5%) stddev-sans-first:2620.08 18:27:05 INFO - PROCESS | 1507 | Values: 1372.5 1521.5 1561.8 1772.2 1891.4 6849.8 7194.9 7325.5 7325.7 7329.2 7266.7 7349.7 7407.2 7414.1 7417.2 2291.8 2315.1 2316.6 2317.5 2349.3 2265.9 2306.7 2381.3 2384.3 2390.6 2214.8 2235.3 2237.7 2262.9 2265.0 2299.9 2356.1 2358.6 2364.3 2366.9 2304.1 2311.8 2318.5 2325.1 2326.0 6590.4 6722.1 7579.6 7612.8 7629.7 4322.5 4564.5 4678.5 4681.4 4682.8 2971.5 2999.6 3002.5 3009.1 3167.0 1024.7 1031.7 1038.2 1070.9 1071.2 9942.6 10057.6 10061.7 10064.8 10193.3 4288.2 4294.6 4310.1 4346.8 4364.6 9138.5 9141.5 9149.3 9156.4 9173.9 4836.7 4850.1 4850.9 4851.0 4854.3 4418.8 4420.8 4422.1 4429.8 4446.0 3641.7 3694.6 3715.7 3724.5 3787.7 1200.0 1202.8 1208.6 1213.0 1213.4 1141.2 1150.1 1176.8 1183.3 1200.4 6919.7 6956.3 7043.5 7116.4 7136.3 1188.3 1188.6 1191.7 1198.9 1205.4 5264.6 5697.3 5761.4 5763.2 5764.8 8246.9 8324.7 8467.4 8501.6 8514.8 8417.2 8425.2 8426.5 8448.2 8539.9 7133.4 7265.5 7273.9 7275.7 7290.3 6853.8 7177.4 7222.2 7235.9 7236.4 7814.2 7941.9 7952.3 8059.4 8074.3 7952.2 8204.7 8230.4 8238.7 8245.1 6664.8 6717.1 6739.1 6774.5 6782.6 7259.2 7302.5 7305.2 7332.7 7337.6 6750.4 6895.4 7014.0 7143.6 7143.9 6691.5 6797.3 6865.4 6894.7 6896.2 6585.4 6714.7 6765.5 6776.0 6813.9 6289.8 6351.7 6351.8 6354.1 6354.3 6326.2 6390.5 6420.7 6426.0 6431.0 18:27:05 INFO - PROCESS | 1507 | 18:27:05 INFO - PROCESS | 1507 | [#4] prototype.html Cycles:180 Average:5376.75 Median:6093.47 stddev:1587.95 (26.1%) stddev-sans-first:1546.93 18:27:05 INFO - PROCESS | 1507 | Values: 349.4 352.4 353.9 356.6 359.0 6058.5 6069.3 6084.3 6086.8 6096.1 5790.2 5814.9 5904.2 5939.8 5949.7 4596.3 4602.4 4624.6 4629.0 4665.4 4516.2 4645.9 4674.0 4674.1 4677.5 4493.1 4567.8 4612.8 4617.7 4620.1 4584.6 4599.4 4609.0 4612.7 4621.0 4107.7 4108.7 4111.4 4112.8 4122.8 5581.5 5708.4 5714.0 5722.4 5726.2 5398.2 5411.7 5414.4 5423.4 5430.4 6395.1 6425.0 6425.4 6428.5 6439.1 4594.8 4597.5 4605.5 4608.4 4608.6 6501.7 6588.5 6638.1 6641.5 6644.9 4690.2 4692.5 4694.5 4698.9 4700.2 4755.9 4760.0 4762.5 4763.8 4764.4 5409.7 5414.1 5416.5 5416.7 5416.8 6281.7 6411.4 6435.4 6440.9 6441.6 1672.6 1693.1 1696.5 1697.9 1698.4 1115.6 1135.2 1136.6 1137.6 1141.1 6107.6 6116.7 6144.7 6145.1 6146.6 6368.3 6585.0 6587.5 6592.2 6597.7 6006.5 6090.8 6145.4 6160.8 6189.1 3488.6 3533.9 3555.3 3559.1 3559.2 6704.2 6795.8 6798.3 6823.1 6825.0 6723.7 6740.0 6776.4 6797.9 6807.9 6795.7 6801.1 6804.0 6808.3 6810.1 6469.6 6589.4 6595.2 6595.6 6633.7 6482.5 6501.9 6503.9 6506.7 6528.0 6803.3 6805.2 6806.3 6813.8 6818.0 4736.7 4757.5 4767.1 4768.5 4771.1 6423.9 6587.0 6602.4 6606.6 6608.2 6362.7 6398.3 6411.3 6415.9 6422.6 6354.7 6429.2 6455.4 6457.4 6467.5 6340.8 6350.6 6355.3 6361.3 6363.2 6464.0 6473.7 6478.5 6479.2 6483.8 6145.5 6292.0 6303.8 6314.9 6322.0 18:27:05 INFO - PROCESS | 1507 | 18:27:05 INFO - PROCESS | 1507 | [#5] yui.html Cycles:180 Average:14382.82 Median:4490.83 stddev:16282.24 (362.6%) stddev-sans-first:16296.02 18:27:05 INFO - PROCESS | 1507 | Values: 812.7 823.7 828.2 832.2 841.2 14399.8 14506.5 14706.7 14732.9 15259.3 14469.3 14534.7 14541.7 14544.7 14553.9 753.2 758.8 889.2 906.7 907.1 878.1 893.8 900.2 902.7 902.7 950.2 954.0 955.4 955.8 955.9 785.0 785.7 787.9 932.2 945.1 689.9 691.1 701.5 701.8 702.6 14829.1 14904.3 14906.2 14909.8 14925.1 13662.2 13723.5 14012.1 14452.9 14559.5 10455.9 10508.8 10557.3 10571.4 10653.7 3902.3 3924.8 3937.8 3942.4 3943.1 49883.5 50775.5 52839.2 53093.5 53334.2 10832.8 10899.5 11077.3 11119.6 11218.2 19523.4 19551.9 19561.2 19592.3 19619.2 7840.6 7877.6 8095.6 8169.6 8227.9 4354.5 4486.4 4495.2 4521.4 4531.5 3196.4 3220.0 3230.8 3234.5 3272.3 551.6 564.6 570.1 573.7 587.9 578.6 612.5 653.9 658.5 662.2 8578.2 8618.2 8766.7 8833.7 9013.4 533.6 560.9 659.1 664.0 691.6 4134.4 4351.8 4369.3 4385.9 4394.2 55925.0 56669.7 57768.4 57878.0 60345.0 51705.5 52717.7 52889.2 52948.7 53267.5 45646.0 46006.0 46158.3 46793.8 47052.5 8283.6 8434.1 8499.1 8548.2 8565.4 34270.1 34473.7 35735.6 37004.1 37554.8 43319.4 43831.8 44074.0 44506.1 47309.3 11921.7 12116.0 12556.4 12940.5 12977.0 13114.8 13222.1 13438.8 13569.9 14018.9 10898.0 11069.7 11262.8 12006.3 12281.0 12469.5 12528.4 12583.7 12697.7 12855.7 9512.6 11130.0 11153.9 11331.0 11492.3 9784.5 9811.3 9960.7 10175.5 10176.4 9955.5 10091.3 10130.5 10184.3 10208.0 18:27:05 INFO - PROCESS | 1507 | -------- Summary: end -------- 18:27:05 INFO - PROCESS | 1507 | 18:27:06 INFO - TEST-INFO | 1507: exit 0 18:27:06 INFO - TEST-OK | dromaeo_css | took 1110286ms 18:27:06 INFO - TEST-START | kraken 18:27:06 INFO - operating with platform_type : linux_ 18:27:06 INFO - Initialising browser for kraken test... 18:27:06 INFO - TEST-INFO | started process 1702 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmputRLEF/profile http://localhost:40316/getInfo.html) 18:27:10 INFO - PROCESS | 1702 | __metrics Screen width/height:1600/1200 18:27:10 INFO - PROCESS | 1702 | colorDepth:24 18:27:10 INFO - PROCESS | 1702 | Browser inner width/height: 1024/697 18:27:10 INFO - PROCESS | 1702 | __metrics 18:27:10 INFO - PROCESS | 1702 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:27:11 INFO - TEST-INFO | 1702: exit 0 18:27:11 INFO - Browser initialized. 18:27:11 INFO - Running cycle 1/1 for kraken test... 18:27:11 INFO - TEST-INFO | started process 1791 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmputRLEF/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:27:23 INFO - PROCESS | 1791 | RSS: Main: 137039872 18:27:23 INFO - PROCESS | 1791 | 18:27:25 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:40316/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40316/tests/kraken/driver.html?testName=audio-beat-detection) 18:27:26 INFO - PROCESS | 1791 | RSS: Main: 172707840 18:27:26 INFO - PROCESS | 1791 | 18:27:28 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:40316/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40316/tests/kraken/driver.html?testName=audio-dft) 18:27:29 INFO - PROCESS | 1791 | RSS: Main: 169205760 18:27:29 INFO - PROCESS | 1791 | 18:27:32 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:40316/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40316/tests/kraken/driver.html?testName=audio-fft) 18:27:32 INFO - PROCESS | 1791 | RSS: Main: 167235584 18:27:32 INFO - PROCESS | 1791 | 18:27:34 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:40316/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40316/tests/kraken/driver.html?testName=audio-oscillator) 18:27:35 INFO - PROCESS | 1791 | RSS: Main: 165904384 18:27:35 INFO - PROCESS | 1791 | 18:27:37 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:40316/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40316/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:27:38 INFO - PROCESS | 1791 | RSS: Main: 165523456 18:27:38 INFO - PROCESS | 1791 | 18:27:40 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:40316/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40316/tests/kraken/driver.html?testName=imaging-darkroom) 18:27:41 INFO - PROCESS | 1791 | RSS: Main: 164282368 18:27:41 INFO - PROCESS | 1791 | 18:27:44 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:40316/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40316/tests/kraken/driver.html?testName=imaging-desaturate) 18:27:45 INFO - PROCESS | 1791 | RSS: Main: 166150144 18:27:45 INFO - PROCESS | 1791 | 18:27:48 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:40316/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40316/tests/kraken/driver.html?testName=json-parse-financial) 18:27:48 INFO - PROCESS | 1791 | RSS: Main: 165470208 18:27:48 INFO - PROCESS | 1791 | 18:27:50 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:40316/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40316/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:27:50 INFO - PROCESS | 1791 | RSS: Main: 168665088 18:27:50 INFO - PROCESS | 1791 | 18:27:52 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:40316/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40316/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:27:53 INFO - PROCESS | 1791 | RSS: Main: 166428672 18:27:53 INFO - PROCESS | 1791 | 18:27:55 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:40316/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40316/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:27:55 INFO - PROCESS | 1791 | RSS: Main: 172851200 18:27:55 INFO - PROCESS | 1791 | 18:27:58 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:40316/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:27:58 INFO - PROCESS | 1791 | RSS: Main: 175501312 18:27:58 INFO - PROCESS | 1791 | 18:28:01 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:40316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:28:01 INFO - PROCESS | 1791 | RSS: Main: 173875200 18:28:01 INFO - PROCESS | 1791 | 18:28:03 INFO - PROCESS | 1791 | Cycle 1(1): loaded http://localhost:40316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40316/tests/kraken/driver.html?testName=ai-astar) 18:28:03 INFO - PROCESS | 1791 | RSS: Main: 234143744 18:28:03 INFO - PROCESS | 1791 | 18:28:03 INFO - PROCESS | 1791 | __start_tp_report 18:28:03 INFO - PROCESS | 1791 | _x_x_mozilla_page_load 18:28:03 INFO - PROCESS | 1791 | _x_x_mozilla_page_load_details 18:28:03 INFO - PROCESS | 1791 | |i|pagename|runs| 18:28:03 INFO - PROCESS | 1791 | |0;ai-astar;111;112;107;112;111;112;101;111;110;111 18:28:03 INFO - PROCESS | 1791 | |1;audio-beat-detection;154;122;149;158;126;149;157;129;165;122 18:28:03 INFO - PROCESS | 1791 | |2;audio-dft;160;159;161;160;161;161;160;161;161;160 18:28:03 INFO - PROCESS | 1791 | |3;audio-fft;76;73;75;155;76;76;74;76;155;73 18:28:03 INFO - PROCESS | 1791 | |4;audio-oscillator;95;96;142;95;96;95;142;94;95;145 18:28:03 INFO - PROCESS | 1791 | |5;imaging-gaussian-blur;109;109;110;108;110;110;109;110;109;109 18:28:03 INFO - PROCESS | 1791 | |6;imaging-darkroom;145;147;145;145;145;146;146;145;146;146 18:28:03 INFO - PROCESS | 1791 | |7;imaging-desaturate;96;96;96;96;95;95;95;95;96;96 18:28:03 INFO - PROCESS | 1791 | |8;json-parse-financial;53;55;54;54;54;54;55;54;53;53 18:28:03 INFO - PROCESS | 1791 | |9;json-stringify-tinderbox;63;63;64;64;64;65;64;64;64;64 18:28:03 INFO - PROCESS | 1791 | |10;stanford-crypto-aes;78;78;78;78;78;78;78;78;77;80 18:28:03 INFO - PROCESS | 1791 | |11;stanford-crypto-ccm;116;111;111;117;114;109;117;111;113;119 18:28:03 INFO - PROCESS | 1791 | |12;stanford-crypto-pbkdf2;136;133;134;135;145;135;133;133;122;144 18:28:03 INFO - PROCESS | 1791 | |13;stanford-crypto-sha256-iterative;64;65;65;64;65;64;63;63;63;65 18:28:03 INFO - PROCESS | 1791 | __end_tp_report 18:28:03 INFO - PROCESS | 1791 | __start_cc_report 18:28:03 INFO - PROCESS | 1791 | _x_x_mozilla_cycle_collect,903 18:28:03 INFO - PROCESS | 1791 | __end_cc_report 18:28:03 INFO - PROCESS | 1791 | __startTimestamp1458869283543__endTimestamp 18:28:03 INFO - PROCESS | 1791 | 18:28:03 INFO - PROCESS | 1791 | ------- Summary: start ------- 18:28:03 INFO - PROCESS | 1791 | Number of tests: 14 18:28:03 INFO - PROCESS | 1791 | 18:28:03 INFO - PROCESS | 1791 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.43 (3.1%) stddev-sans-first:3.61 18:28:03 INFO - PROCESS | 1791 | Values: 111.0 112.0 107.0 112.0 111.0 112.0 101.0 111.0 110.0 111.0 18:28:03 INFO - PROCESS | 1791 | 18:28:03 INFO - PROCESS | 1791 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:151.50 stddev:16.55 (10.9%) stddev-sans-first:17.08 18:28:03 INFO - PROCESS | 1791 | Values: 154.0 122.0 149.0 158.0 126.0 149.0 157.0 129.0 165.0 122.0 18:28:03 INFO - PROCESS | 1791 | 18:28:03 INFO - PROCESS | 1791 | [#2] audio-dft Cycles:10 Average:160.40 Median:161.00 stddev:0.70 (0.4%) stddev-sans-first:0.73 18:28:03 INFO - PROCESS | 1791 | Values: 160.0 159.0 161.0 160.0 161.0 161.0 160.0 161.0 161.0 160.0 18:28:03 INFO - PROCESS | 1791 | 18:28:03 INFO - PROCESS | 1791 | [#3] audio-fft Cycles:10 Average:90.90 Median:75.50 stddev:33.80 (44.8%) stddev-sans-first:35.42 18:28:03 INFO - PROCESS | 1791 | Values: 76.0 73.0 75.0 155.0 76.0 76.0 74.0 76.0 155.0 73.0 18:28:03 INFO - PROCESS | 1791 | 18:28:03 INFO - PROCESS | 1791 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:95.00 stddev:23.14 (24.4%) stddev-sans-first:23.94 18:28:03 INFO - PROCESS | 1791 | Values: 95.0 96.0 142.0 95.0 96.0 95.0 142.0 94.0 95.0 145.0 18:28:03 INFO - PROCESS | 1791 | 18:28:03 INFO - PROCESS | 1791 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 18:28:03 INFO - PROCESS | 1791 | Values: 109.0 109.0 110.0 108.0 110.0 110.0 109.0 110.0 109.0 109.0 18:28:03 INFO - PROCESS | 1791 | 18:28:03 INFO - PROCESS | 1791 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 18:28:03 INFO - PROCESS | 1791 | Values: 145.0 147.0 145.0 145.0 145.0 146.0 146.0 145.0 146.0 146.0 18:28:03 INFO - PROCESS | 1791 | 18:28:03 INFO - PROCESS | 1791 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 18:28:03 INFO - PROCESS | 1791 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 18:28:03 INFO - PROCESS | 1791 | 18:28:03 INFO - PROCESS | 1791 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:0.74 (1.4%) stddev-sans-first:0.71 18:28:03 INFO - PROCESS | 1791 | Values: 53.0 55.0 54.0 54.0 54.0 54.0 55.0 54.0 53.0 53.0 18:28:03 INFO - PROCESS | 1791 | 18:28:03 INFO - PROCESS | 1791 | [#9] json-stringify-tinderbox Cycles:10 Average:63.90 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 18:28:03 INFO - PROCESS | 1791 | Values: 63.0 63.0 64.0 64.0 64.0 65.0 64.0 64.0 64.0 64.0 18:28:03 INFO - PROCESS | 1791 | 18:28:03 INFO - PROCESS | 1791 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:78.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 18:28:03 INFO - PROCESS | 1791 | Values: 78.0 78.0 78.0 78.0 78.0 78.0 78.0 78.0 77.0 80.0 18:28:03 INFO - PROCESS | 1791 | 18:28:03 INFO - PROCESS | 1791 | [#11] stanford-crypto-ccm Cycles:10 Average:113.80 Median:115.00 stddev:3.33 (2.9%) stddev-sans-first:3.43 18:28:03 INFO - PROCESS | 1791 | Values: 116.0 111.0 111.0 117.0 114.0 109.0 117.0 111.0 113.0 119.0 18:28:03 INFO - PROCESS | 1791 | 18:28:03 INFO - PROCESS | 1791 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.00 Median:135.00 stddev:6.36 (4.7%) stddev-sans-first:6.74 18:28:03 INFO - PROCESS | 1791 | Values: 136.0 133.0 134.0 135.0 145.0 135.0 133.0 133.0 122.0 144.0 18:28:03 INFO - PROCESS | 1791 | 18:28:03 INFO - PROCESS | 1791 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.50 stddev:0.88 (1.4%) stddev-sans-first:0.93 18:28:03 INFO - PROCESS | 1791 | Values: 64.0 65.0 65.0 64.0 65.0 64.0 63.0 63.0 63.0 65.0 18:28:03 INFO - PROCESS | 1791 | -------- Summary: end -------- 18:28:03 INFO - PROCESS | 1791 | 18:28:04 INFO - TEST-INFO | 1791: exit 0 18:28:04 INFO - TEST-OK | kraken | took 58147ms 18:28:04 INFO - TEST-START | v8_7 18:28:04 INFO - operating with platform_type : linux_ 18:28:04 INFO - Initialising browser for v8_7 test... 18:28:04 INFO - TEST-INFO | started process 2042 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfRJYx_/profile http://localhost:40316/getInfo.html) 18:28:08 INFO - PROCESS | 2042 | __metrics Screen width/height:1600/1200 18:28:08 INFO - PROCESS | 2042 | colorDepth:24 18:28:08 INFO - PROCESS | 2042 | Browser inner width/height: 1024/697 18:28:08 INFO - PROCESS | 2042 | __metrics 18:28:08 INFO - PROCESS | 2042 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:28:09 INFO - TEST-INFO | 2042: exit 0 18:28:09 INFO - Browser initialized. 18:28:09 INFO - Running cycle 1/1 for v8_7 test... 18:28:09 INFO - TEST-INFO | started process 2135 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfRJYx_/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:28:21 INFO - PROCESS | 2135 | RSS: Main: 136482816 18:28:21 INFO - PROCESS | 2135 | 18:28:43 INFO - PROCESS | 2135 | Cycle 1(1): loaded http://localhost:40316/tests/v8_7/run.html (next: http://localhost:40316/tests/v8_7/run.html) 18:28:43 INFO - PROCESS | 2135 | RSS: Main: 419532800 18:28:43 INFO - PROCESS | 2135 | 18:28:43 INFO - PROCESS | 2135 | __start_tp_report 18:28:43 INFO - PROCESS | 2135 | _x_x_mozilla_page_load 18:28:43 INFO - PROCESS | 2135 | _x_x_mozilla_page_load_details 18:28:43 INFO - PROCESS | 2135 | |i|pagename|runs| 18:28:43 INFO - PROCESS | 2135 | |0;Richards;166.61112962345885 18:28:43 INFO - PROCESS | 2135 | |1;DeltaBlue;168.0672268907563 18:28:43 INFO - PROCESS | 2135 | |2;Encrypt;279.79854504756577 18:28:43 INFO - PROCESS | 2135 | |3;Decrypt;5317.460317460317 18:28:43 INFO - PROCESS | 2135 | |4;RayTrace;962.4639076034649 18:28:43 INFO - PROCESS | 2135 | |5;Earley;565.9309564233164 18:28:43 INFO - PROCESS | 2135 | |6;Boyer;10691.489361702128 18:28:43 INFO - PROCESS | 2135 | |7;RegExp;39509.80392156863 18:28:43 INFO - PROCESS | 2135 | |8;Splay;496.5312190287413 18:28:43 INFO - PROCESS | 2135 | |9;NavierStokes;4826.923076923077 18:28:43 INFO - PROCESS | 2135 | __end_tp_report 18:28:43 INFO - PROCESS | 2135 | __startTimestamp1458869323904__endTimestamp 18:28:43 INFO - PROCESS | 2135 | 18:28:43 INFO - PROCESS | 2135 | ------- Summary: start ------- 18:28:43 INFO - PROCESS | 2135 | Number of tests: 10 18:28:43 INFO - PROCESS | 2135 | 18:28:43 INFO - PROCESS | 2135 | [#0] Richards Cycles:1 Average:166.61 Median:166.61 stddev:0.00 (0.0%) 18:28:43 INFO - PROCESS | 2135 | Values: 166.6 18:28:43 INFO - PROCESS | 2135 | 18:28:43 INFO - PROCESS | 2135 | [#1] DeltaBlue Cycles:1 Average:168.07 Median:168.07 stddev:0.00 (0.0%) 18:28:43 INFO - PROCESS | 2135 | Values: 168.1 18:28:43 INFO - PROCESS | 2135 | 18:28:43 INFO - PROCESS | 2135 | [#2] Encrypt Cycles:1 Average:279.80 Median:279.80 stddev:0.00 (0.0%) 18:28:43 INFO - PROCESS | 2135 | Values: 279.8 18:28:43 INFO - PROCESS | 2135 | 18:28:43 INFO - PROCESS | 2135 | [#3] Decrypt Cycles:1 Average:5317.46 Median:5317.46 stddev:0.00 (0.0%) 18:28:43 INFO - PROCESS | 2135 | Values: 5317.5 18:28:43 INFO - PROCESS | 2135 | 18:28:43 INFO - PROCESS | 2135 | [#4] RayTrace Cycles:1 Average:962.46 Median:962.46 stddev:0.00 (0.0%) 18:28:43 INFO - PROCESS | 2135 | Values: 962.5 18:28:43 INFO - PROCESS | 2135 | 18:28:43 INFO - PROCESS | 2135 | [#5] Earley Cycles:1 Average:565.93 Median:565.93 stddev:0.00 (0.0%) 18:28:43 INFO - PROCESS | 2135 | Values: 565.9 18:28:43 INFO - PROCESS | 2135 | 18:28:43 INFO - PROCESS | 2135 | [#6] Boyer Cycles:1 Average:10691.49 Median:10691.49 stddev:0.00 (0.0%) 18:28:43 INFO - PROCESS | 2135 | Values: 10691.5 18:28:43 INFO - PROCESS | 2135 | 18:28:43 INFO - PROCESS | 2135 | [#7] RegExp Cycles:1 Average:39509.80 Median:39509.80 stddev:0.00 (0.0%) 18:28:43 INFO - PROCESS | 2135 | Values: 39509.8 18:28:43 INFO - PROCESS | 2135 | 18:28:43 INFO - PROCESS | 2135 | [#8] Splay Cycles:1 Average:496.53 Median:496.53 stddev:0.00 (0.0%) 18:28:43 INFO - PROCESS | 2135 | Values: 496.5 18:28:43 INFO - PROCESS | 2135 | 18:28:43 INFO - PROCESS | 2135 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 18:28:43 INFO - PROCESS | 2135 | Values: 4826.9 18:28:43 INFO - PROCESS | 2135 | -------- Summary: end -------- 18:28:43 INFO - PROCESS | 2135 | 18:28:44 INFO - TEST-INFO | 2135: exit 0 18:28:44 INFO - TEST-OK | v8_7 | took 40283ms 18:28:44 INFO - SUITE-END | took 1208s 18:28:44 INFO - Completed test suite (00:20:08) 18:28:44 INFO - Working with test: dromaeo_css 18:28:44 INFO - Generating results file: dromaeo_css 18:28:44 INFO - Working with test: kraken 18:28:44 INFO - Generating results file: kraken 18:28:44 INFO - javascript benchmark 18:28:44 INFO - Working with test: v8_7 18:28:44 INFO - Generating results file: v8_7 18:28:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:28:45 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 18:28:45 INFO - process_Request line: dromaeo_css 6982.86 graph.html#tests=[[72,53,35]] 18:28:45 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:28:45 INFO - process_Request line: kraken 1473.00 graph.html#tests=[[232,53,35]] 18:28:45 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:28:45 INFO - process_Request line: v8_7 22074.75 graph.html#tests=[[230,53,35]] 18:28:45 INFO - RETURN: dromaeo_css: 6982.86 18:28:45 INFO - RETURN: kraken: 1473.00 18:28:45 INFO - RETURN: v8_7: 22074.75 18:28:45 INFO - javascript benchmark 18:28:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3149.3228955774503, 3153.7950033247853, 3175.3966746318197, 3186.7131958123764, 3207.1501052221165, 5150.227465880111, 5174.120399532079, 5180.404253510847, 5184.818531351399, 5196.92204616931, 5141.0, 5183.092958732216, 5200.713960732158, 5207.6875387476775, 5237.47625237476, 4671.649626278026, 4726.952730472694, 4735.73953432561, 4775.3075804008395, 4797.2324428091515, 4824.927626085611, 4844.757762111898, 4868.391451068616, 4881.926771098419, 4882.389701287339, 4835.032993401333, 4839.225723884179, 4868.513148685139, 4881.633877459187, 4886.169351210303, 4747.45404278509, 4782.880427989293, 4827.8310259140935, 4847.12751704693, 4863.8784030399165, 4740.715557066587, 4768.260919557474, 4774.379330686988, 4781.832635857728, 4807.807687692488, 4956.430010548797, 5036.496350364971, 5051.621128415383, 5060.038592667418, 5147.150720131174, 5536.889262214733, 5561.388247292794, 5592.748326325325, 5606.831795046155, 5626.127950167731, 5535.086710692731, 5587.329520457531, 5596.748146333425, 5600.0759874620635, 5611.494965453129, 5080.644354895159, 5215.6609820361555, 5234.0, 5239.711815850127, 5249.895002099936, 5659.886802263932, 5681.0910254359105, 5683.460071293221, 5700.087985922232, 5701.4298570142655, 5477.233187353773, 5483.561315094783, 5484.314460692413, 5484.341878974548, 5487.341519017744, 5472.753726082336, 5540.36285827135, 5552.611317207757, 5581.190727344512, 5631.774729010794, 5516.365617953987, 5535.6955367455175, 5539.169124631338, 5544.445555444423, 5549.528290095306, 5552.333719953632, 5566.276384070045, 5566.693831839207, 5579.553635709133, 5580.135079062752, 4270.658347332206, 4320.611144996966, 4324.286492728727, 4357.063231405263, 4382.737035777864, 3850.4609354690365, 3858.8456461741775, 3859.1124041470057, 3863.343231650626, 3883.2427676603356, 5087.364079490064, 5222.738863056832, 5231.71225582589, 5233.973830130825, 5259.631825772236, 5531.612787104864, 5549.223108764776, 5619.494245517923, 5622.24099746529, 5638.323401191801, 5136.049830781318, 5167.302414174113, 5167.586593072545, 5169.172932330885, 5201.193814958688, 4710.52894710533, 4743.241081426955, 4781.2350023996, 4789.44921334051, 4792.880177995578, 5624.21261023457, 5675.914861277084, 5696.0, 5696.287964004499, 5732.111522713986, 5599.32808063035, 5608.355039170385, 5622.6064175508955, 5623.184638227516, 5629.7748090077575, 5637.069883469182, 5688.857778555569, 5724.57065720081, 5776.595638305278, 5782.855428614318, 5562.805301814417, 5567.025770490067, 5568.526675232651, 5569.582281328998, 5578.051731205624, 5603.691796951207, 5605.24329215567, 5606.215129881738, 5607.719614019365, 5615.775368985195, 5315.946840531546, 5393.6763794172475, 5469.644473109235, 5526.0, 5551.22282880389, 5467.234587157881, 5496.065668836387, 5499.092649712753, 5499.835004949858, 5501.779928802963, 5349.518543331119, 5410.269613602113, 5414.133738601805, 5419.376771671308, 5450.727463626724, 5398.325209348832, 5417.729113544228, 5476.91784623223, 5496.31296087989, 5550.111982082847, 5230.476952304739, 5270.868228294324, 5271.0, 5302.3637163540625, 5328.920066199088], "unit": "score", "name": "dojo.html", "value": 5149.662625028101}, {"lowerIsBetter": false, "replicates": [560.6888177061729, 560.7168379968116, 579.7651950959863, 581.2937281203338, 586.6128355285512, 30994.2251443714, 31558.526622100628, 31733.841330793344, 38455.42316865242, 38835.80582097093, 42668.0, 42887.14225715484, 43042.35436468456, 43042.35436468456, 43113.78443107788, 8701.216890479856, 8895.154960278764, 8913.643454261823, 8916.331275154356, 8916.955415222916, 8591.785205369884, 8737.301015918743, 8752.781180470507, 8787.472751634923, 8788.209061184492, 8971.147740964598, 9031.051739567349, 9043.728688139367, 9055.003949565542, 9063.365564410495, 8906.51014194219, 9010.729678109667, 9023.593938272761, 9025.593848276778, 9026.097390260988, 8788.780280492974, 8929.687460938901, 8931.910680893174, 8935.865962010575, 8936.0, 41761.95595110116, 42522.57477425217, 42564.787176063925, 42576.3613545794, 42601.78699106516, 3555.1467647764607, 3559.857605695769, 3572.3212589607892, 3575.3921833288405, 3575.8212089395424, 31095.68904310973, 31170.064898053093, 31413.8429307852, 31695.683043169734, 32750.508742368882, 3920.8039598019986, 3991.8004099794894, 4036.576159503239, 4077.8980525486804, 4093.3655283431117, 293029.0, 293241.0, 293870.0, 294372.0, 294833.0, 57367.42632573621, 58287.70856145692, 61896.28622282678, 62532.0, 62981.37018629755, 61730.38269617246, 62071.37928620746, 62213.68893155505, 62463.0, 62482.0, 17864.196111175028, 18157.7276340855, 18168.091595420177, 18173.0, 18180.36368727088, 12403.503859845505, 12435.564755233523, 12496.187747796364, 12597.307148106942, 12645.114841961158, 20127.496812579804, 20557.794422055886, 20602.27892023772, 20602.27892023772, 20608.793912060988, 7532.54804711719, 7769.53382797034, 7786.571738554434, 7798.376129909707, 7830.295273425305, 1044.8746150461993, 1075.8440026196158, 1081.4754843900703, 1092.1590375411047, 1147.1912301827192, 30434.239144021132, 30537.0, 30833.0, 31354.372912542076, 31916.361672766878, 1092.2136062035322, 1155.757290968889, 1160.8665003524534, 1182.9585964491203, 1211.19455562052, 12455.93772031134, 14592.562223133324, 15047.437954324798, 15936.521904342888, 16111.677766444605, 277125.0, 280112.0, 280339.0, 281567.0, 281925.0, 53607.73196134072, 53783.50407223518, 53816.0, 53824.73087634537, 53929.46070539323, 1328.16325714801, 1335.8530561638213, 1439.6760728835927, 1464.985350146506, 1479.659678274003, 26619.60070598904, 26841.0, 26886.731132688423, 27207.455850882474, 30081.247968800955, 47214.0, 47469.28796068131, 47582.0, 47602.52397475981, 47614.76192619015, 200975.0, 333641.0, 337174.0, 337964.0, 338768.0, 31563.84218078895, 32122.0, 32268.19329516781, 32300.0, 32342.83828580842, 43740.0, 44268.33597495976, 44784.552154478035, 45471.54528454673, 45547.089058217985, 35994.82002590075, 36573.0, 37257.254854903294, 37639.0, 40689.38965915454, 39783.60216397799, 40540.1891962165, 40636.18727625372, 41191.588084118775, 41374.58625413707, 40273.597264028154, 40387.394189087776, 40421.1915761689, 40753.38869916894, 40842.0, 36308.9426865232, 36522.269554608225, 36697.0, 36920.81539592392, 37283.81358093192, 27504.44991100207, 27515.31211719723, 27575.43344692934, 27663.0, 27670.0], "unit": "score", "name": "ext.html", "value": 19223.59426085174}, {"lowerIsBetter": false, "replicates": [390.9354956432188, 392.621120618603, 394.15650507913074, 395.25494442975, 399.1816775609999, 14328.570142895729, 15545.844541554581, 16232.350705971761, 18117.547061323472, 18172.18225179867, 11763.470643821027, 11997.700057498545, 12011.519539218443, 13926.79109813351, 17915.552111197227, 5081.872953176182, 5268.394134674523, 5272.103742363788, 5280.075986702331, 5280.1815718563685, 4030.2141082488924, 4175.331946888498, 5157.149070403379, 5480.232767412565, 5676.432356764311, 5354.330708661418, 5669.574781891354, 5688.60179787415, 5693.259876216086, 5707.828765137032, 5424.240606315079, 5456.508914197741, 5466.426025267349, 5486.643368181076, 5500.367457742371, 5561.110222364402, 5613.859653508654, 5615.80344687938, 5618.353889302742, 5626.0, 13003.349832508336, 13230.735385292337, 13244.139130956457, 13246.0, 13682.31588420575, 2157.6871353653632, 2217.102073660154, 2243.697100891375, 2249.0778780699998, 2257.932262032142, 10870.945645271722, 13324.533641322603, 13374.665633359147, 13677.042607017513, 13789.51736689211, 1934.516370907273, 1976.2885361269932, 1980.722698822166, 2073.844461665366, 2074.222166687492, 62278.0, 62689.37310626881, 63974.68012659954, 64874.67562662157, 65160.67419662919, 10502.894971050191, 11006.229563930448, 11072.501737421835, 11134.610288639858, 11143.219974601861, 14544.927275363767, 14644.341004654816, 14647.707045859237, 14683.48607798722, 14689.485867994568, 8106.351491880753, 8144.226298501633, 8519.48883067018, 8540.316774658013, 8594.699185528476, 8301.086880443147, 8334.249917507454, 8356.916430835736, 8425.873611895826, 8431.662733490715, 4362.716423432466, 4694.413198350207, 4699.107169637827, 4718.339432479455, 4803.063402636452, 1736.1143837359361, 1886.4340697790608, 1919.5297152197802, 1920.3278852401827, 1941.3496478679517, 461.4831388844516, 462.19577934393914, 464.5261832930392, 1016.425719468498, 1051.2115913065202, 9951.601935922627, 10960.0, 11143.888561114285, 11234.269772464764, 11508.367039812723, 484.2566660176612, 493.2133247470351, 495.46242327074805, 499.07670809003054, 513.2378418049194, 9758.316917815826, 10259.230557708202, 10315.071643551966, 10338.896611033793, 10349.223808214414, 629420.6760695688, 632857.0, 645395.0, 657249.0, 666924.0, 78789.60605196937, 80256.0, 80788.59605701934, 81128.59435702783, 85355.57322213349, 1224.381687247934, 1244.4897591987242, 1250.9687257818628, 1266.1580049267318, 1268.0806415348798, 14950.551483455514, 15933.760993585338, 16189.352425902833, 16217.918910405373, 16263.0, 31789.20526986844, 31990.52014219742, 33018.33963320768, 33378.16554586155, 33636.1590960228, 38766.4185037219, 40282.597174027884, 40619.390709138796, 40919.0, 42742.57257427386, 7792.376609871083, 8025.8796118059445, 8060.234277743605, 8069.556174410463, 8087.595620218848, 10299.845502317321, 11511.597094101666, 11714.891319562219, 11784.410779461165, 11914.52341906314, 9031.187193152648, 9936.701898943043, 10001.699949001542, 10018.298719089593, 10064.245181611263, 10032.799344012932, 10242.897571024194, 10441.112505437122, 10688.83966740484, 10805.945970270099, 7691.50005249657, 9646.469444180637, 10046.648367307109, 10067.0, 10458.790824183627, 7742.690292388242, 7836.255555722198, 7856.371490280878, 7858.253465920729, 7889.447738658238, 9226.433507936621, 9754.658586949423, 9874.061964113398, 10215.387076775418, 10243.487825608541], "unit": "score", "name": "jquery.html", "value": 8175.249315936737}, {"lowerIsBetter": false, "replicates": [1372.4647387518876, 1521.513115802943, 1561.828198898121, 1772.220223101835, 1891.3663922585934, 6849.7602583909575, 7194.8920766188485, 7325.487215894889, 7325.743598974037, 7329.157146928112, 7266.672999715012, 7349.669264883079, 7407.185209626937, 7414.1473730521, 7417.221191774867, 2291.8395712300103, 2315.050829160045, 2316.5945959457113, 2317.478567322356, 2349.259983105325, 2265.9433514162197, 2306.6655334976417, 2381.285614315707, 2384.2727967969763, 2390.6175011998084, 2214.8228141748623, 2235.251190851067, 2237.7202849643795, 2262.875541845198, 2265.0373591223665, 2299.9195028173935, 2356.1400088967575, 2358.5990381635165, 2364.2670772060715, 2366.881655917206, 2304.101400453824, 2311.8266130040315, 2318.455163036685, 2325.058351367682, 2325.976740232593, 6590.373914478117, 6722.092517510123, 7579.583122928237, 7612.7716168515035, 7629.7329593463965, 4322.459692538433, 4564.497905230422, 4678.485366609671, 4681.414823147106, 4682.836100736458, 2971.4948458762065, 2999.6100506934176, 3002.519596864513, 3009.0972708187674, 3167.0182243504587, 1024.6977141743203, 1031.6698656429946, 1038.2109596706482, 1070.8875568065396, 1071.23406764164, 9942.602295908155, 10057.597696092147, 10061.748456288578, 10064.798704025952, 10193.337433066752, 4288.228118938621, 4294.570542945743, 4310.051788606502, 4346.7609281489185, 4364.607185353333, 9138.497382644018, 9141.451512909247, 9149.313801464783, 9156.404833685789, 9173.908260917438, 4836.709797412166, 4850.078485087822, 4850.902981940341, 4850.95149048512, 4854.296127061627, 4418.756968366771, 4420.756858372756, 4422.115576884636, 4429.7785110744335, 4446.044100518404, 3641.708663306929, 3694.5751238607368, 3715.7398982071536, 3724.5344331958504, 3787.696984241254, 1200.0459634590522, 1202.753435545711, 1208.6313674329238, 1212.9757404851853, 1213.3751118174148, 1141.2125633312987, 1150.0626989003936, 1176.847009888726, 1183.2900259844025, 1200.429795846983, 6919.7232110715, 6956.304369563003, 7043.506954513237, 7116.430685545144, 7136.3220494052985, 1188.2692144331347, 1188.5780547905542, 1191.6603767926272, 1198.8730593242324, 1205.445495072259, 5264.552513036435, 5697.259356283656, 5761.366249712528, 5763.193152958589, 5764.827055188351, 8246.917530824734, 8324.6670133194, 8467.364947628952, 8501.61742721579, 8514.829703405898, 8417.158284171657, 8425.199606037417, 8426.452280601741, 8448.197421244971, 8539.914600854036, 7133.393661538724, 7265.455090868206, 7273.89089163663, 7275.745348912763, 7290.3438690518105, 6853.7943861684225, 7177.3899218567, 7222.205557388788, 7235.855282894207, 7236.38490728294, 7814.21857814214, 7941.920580794349, 7952.284294413531, 8059.43583949118, 8074.273315401642, 7952.165022672768, 8204.671813127647, 8230.382721295808, 8238.670453181805, 8245.051819040647, 6664.833379165366, 6717.059611654275, 6739.123913891162, 6774.525783195326, 6782.626955517297, 7259.165196002527, 7302.488825782144, 7305.2329505403295, 7332.670029848777, 7337.559746415232, 6750.426213771884, 6895.4138898194215, 7013.964930175316, 7143.607101609461, 7143.9285607143265, 6691.498137639599, 6797.346501072491, 6865.382115609419, 6894.655267236719, 6896.206936202401, 6585.440237579668, 6714.6642667865435, 6765.458763298826, 6776.0, 6813.8977915330315, 6289.779857704958, 6351.71417286214, 6351.841203969753, 6354.078658594385, 6354.301026886947, 6326.240851097898, 6390.48876089921, 6420.7431702731365, 6426.036094585663, 6431.035344698333], "unit": "score", "name": "mootools.html", "value": 4437.189463113109}, {"lowerIsBetter": false, "replicates": [349.42345130534613, 352.3516729218239, 353.9256756081223, 356.6237619311625, 358.9533360663115, 6058.5456090793205, 6069.332373438918, 6084.330723620409, 6086.8478288042825, 6096.085587161928, 5790.218320526727, 5814.912776308359, 5904.232449781533, 5939.762409503614, 5949.732262048207, 4596.333531637911, 4602.424696912894, 4624.630029597624, 4628.976855115719, 4665.370175026362, 4516.2322405191035, 4645.9303110453375, 4673.953260467386, 4674.135284972291, 4677.508861569538, 4493.101379724052, 4567.840125595605, 4612.769361531927, 4617.676762626617, 4620.099080679269, 4584.633229341644, 4599.356090147348, 4609.03210325832, 4612.654050946176, 4621.0, 4107.732997355162, 4108.712390132692, 4111.362738775495, 4112.753234805921, 4122.793860307002, 5581.469760372758, 5708.40061793514, 5714.028615135437, 5722.399148089474, 5726.198332233491, 5398.24424580559, 5411.702356370398, 5414.377346605152, 5423.403425623178, 5430.402655707909, 6395.104685344056, 6424.967875160594, 6425.357464253584, 6428.485721142298, 6439.098526206288, 4594.816207351702, 4597.494275629678, 4605.4933957264675, 4608.400907881987, 4608.6082682971655, 6501.707423165922, 6588.4729221662155, 6638.070670106189, 6641.535092543524, 6644.900326495106, 4690.15577196108, 4692.53074692528, 4694.483606803317, 4698.859034228979, 4700.177468942921, 4755.857324280208, 4759.952400476021, 4762.499937506581, 4763.809447622126, 4764.404449443819, 5409.675419474844, 5414.052540805422, 5416.458354164631, 5416.674999500043, 5416.783328666809, 6281.654509001957, 6411.358864113551, 6435.420812126931, 6440.935590644127, 6441.581297215666, 1672.6487437637988, 1693.1111166637613, 1696.5419336779, 1697.9235934382982, 1698.3970690404728, 1115.55935405516, 1135.211028335299, 1136.6362763915633, 1137.5961533655598, 1141.149843366697, 6107.572469927151, 6116.694165291718, 6144.723487443076, 6145.108959200891, 6146.631202127886, 6368.29948705642, 6585.0, 6587.538872278895, 6592.208934927743, 6597.670116494156, 6006.489448396847, 6090.847728806727, 6145.4161854623735, 6160.845978850475, 6189.071639254148, 3488.6162522122545, 3533.876314328986, 3555.3244883472057, 3559.110222444389, 3559.2347645256395, 6704.161979752531, 6795.762148324785, 6798.252192258848, 6823.078884350549, 6825.044493770876, 6723.66381680914, 6739.966300168468, 6776.42400395962, 6797.898031529531, 6807.897881531781, 6795.694193761293, 6801.081853949653, 6804.0, 6808.2510923798345, 6810.080639113657, 6469.611823290617, 6589.439897608565, 6595.175603049619, 6595.604263743999, 6633.734650613921, 6482.513811464065, 6501.894677904673, 6503.934960650522, 6506.707198176188, 6528.0, 6803.285655006351, 6805.217399999064, 6806.319368063352, 6813.761518346834, 6818.0, 4736.715797052188, 4757.524247575215, 4767.070421267819, 4768.451628062817, 4771.093492236464, 6423.907935650857, 6586.967065164644, 6602.438792702482, 6606.570572912745, 6608.173978252718, 6362.713677884413, 6398.264199617103, 6411.294757576569, 6415.871682566416, 6422.6467544285515, 6354.744065856555, 6429.22849258092, 6455.386738259858, 6457.3865482779065, 6467.547271690936, 6340.778072767431, 6350.618962862243, 6355.269144048493, 6361.268454127835, 6363.236411630634, 6463.998080297373, 6473.741050357933, 6478.5141114415665, 6479.1901012373455, 6483.7730679425995, 6145.477634401126, 6292.0, 6303.810885673437, 6314.905276420949, 6321.96839015802], "unit": "score", "name": "prototype.html", "value": 4868.094048086676}, {"lowerIsBetter": false, "replicates": [812.7114874219653, 823.7034667519696, 828.1511450762963, 832.1886160993029, 841.242881406734, 14399.78400323996, 14506.492272770442, 14706.70586588269, 14732.926335368322, 15259.313330900108, 14469.276536173202, 14534.709305813878, 14541.709165816677, 14544.709105817878, 14553.927230363859, 753.1790348520112, 758.8102974256436, 889.1553024626614, 906.6735975048977, 907.0657223060225, 878.1350369885657, 893.7988952485704, 900.1718419054453, 902.715644571961, 902.7201567514091, 950.1543626172712, 953.9570719317647, 955.4219697083269, 955.7801705607715, 955.9378640388353, 784.9607519624025, 785.6503855784179, 787.9369650427981, 932.1563984593886, 945.078548415293, 689.9482538809609, 691.1291772366855, 701.4984286235315, 701.7508784381522, 702.5784529282441, 14829.110253384832, 14904.254787260703, 14906.180160091191, 14909.7763533546, 14925.10449373041, 13662.248576328298, 13723.45106195751, 14012.089214201147, 14452.855471445362, 14559.490417835324, 10455.947720261425, 10508.78982420355, 10557.260991730582, 10571.418571978538, 10653.733656658567, 3902.2975864344407, 3924.803759811998, 3937.7834219117935, 3942.4086387041884, 3943.132510847609, 49883.50116498825, 50775.49224507782, 52839.207411888856, 53093.469065309626, 53334.19998699984, 10832.783344333227, 10899.455027248607, 11077.335359878272, 11119.55521779136, 11218.158638102012, 19523.414297571097, 19551.902240488707, 19561.217551298072, 19592.314269000515, 19619.21523139087, 7840.568768717661, 7877.606119693993, 8095.554744488992, 8169.63236654352, 8227.917720822836, 4354.542773008852, 4486.439195100613, 4495.21333766596, 4521.412216411911, 4531.524189960072, 3196.4246435641808, 3220.0178945421403, 3230.789998650127, 3234.498652708834, 3272.2964562618677, 551.6386766667839, 564.6358099026105, 570.1277046119444, 573.6644063222977, 587.917691523187, 578.5949538607574, 612.4824523277823, 653.8594202246445, 658.5456035335603, 662.2020465339255, 8578.227959483676, 8618.181272779077, 8766.736997890073, 8833.69082082124, 9013.414128081653, 533.6104643610187, 560.9242752228479, 659.1431139518606, 663.9767608133692, 691.6403470195571, 4134.421181034658, 4351.804168812411, 4369.3227549729845, 4385.890352741207, 4394.231009573376, 55925.0, 56669.71665141648, 57768.422315776304, 57878.0, 60345.0, 51705.482945170064, 52717.736411317695, 52889.206661900105, 52948.735256323474, 53267.46732532625, 45646.0, 46006.0, 46158.30762538565, 46793.830154247094, 47052.5294747055, 8283.58582070906, 8434.114417986024, 8499.065102838558, 8548.187922147386, 8565.400421970402, 34270.14324641904, 34473.65526344704, 35735.64264357323, 37004.074898127765, 37554.812225938695, 43319.35020974625, 43831.78084109559, 44074.0, 44506.10987780291, 47309.290360645304, 11921.701957451132, 12116.0, 12556.37218139071, 12940.547080852126, 12977.0, 13114.803277950648, 13222.140560863512, 13438.798418023542, 13569.864301357255, 14018.929905350407, 10898.0, 11069.72325691832, 11262.83105753398, 12006.279623222634, 12281.0, 12469.5012199511, 12528.373581320715, 12583.748325033632, 12697.682557936125, 12855.742885142057, 9512.571934262836, 11130.0, 11153.944230278797, 11331.0, 11492.253003554742, 9784.51077446139, 9811.264155188246, 9960.701178964642, 10175.542100605639, 10176.440295783803, 9955.452450115023, 10091.344062635904, 10130.493475326351, 10184.287099903231, 10208.0], "unit": "score", "name": "yui.html", "value": 6631.01454387799}], "name": "dromaeo_css", "value": 6982.861968982255}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 107.0, 112.0, 111.0, 112.0, 101.0, 111.0, 110.0, 111.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [154.0, 122.0, 149.0, 158.0, 126.0, 149.0, 157.0, 129.0, 165.0, 122.0], "unit": "score", "name": "audio-beat-detection", "value": 143.1}, {"lowerIsBetter": true, "replicates": [160.0, 159.0, 161.0, 160.0, 161.0, 161.0, 160.0, 161.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.4}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 75.0, 155.0, 76.0, 76.0, 74.0, 76.0, 155.0, 73.0], "unit": "score", "name": "audio-fft", "value": 90.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 142.0, 95.0, 96.0, 95.0, 142.0, 94.0, 95.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 108.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 147.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.6}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 53.9}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.9}, {"lowerIsBetter": true, "replicates": [78.0, 78.0, 78.0, 78.0, 78.0, 78.0, 78.0, 78.0, 77.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.1}, {"lowerIsBetter": true, "replicates": [116.0, 111.0, 111.0, 117.0, 114.0, 109.0, 117.0, 111.0, 113.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.8}, {"lowerIsBetter": true, "replicates": [136.0, 133.0, 134.0, 135.0, 145.0, 135.0, 133.0, 133.0, 122.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.0}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 64.0, 63.0, 63.0, 63.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.1}], "name": "kraken", "value": 1472.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.61112962345885], "unit": "score", "name": "Richards", "value": 211.88260400000004}, {"lowerIsBetter": false, "replicates": [168.0672268907563], "unit": "score", "name": "DeltaBlue", "value": 393.40209999999996}, {"lowerIsBetter": false, "replicates": [279.79854504756577], "unit": "score", "name": "Encrypt", "value": 951.330894}, {"lowerIsBetter": false, "replicates": [5317.460317460317], "unit": "score", "name": "Decrypt", "value": 50.057919402985085}, {"lowerIsBetter": false, "replicates": [962.4639076034649], "unit": "score", "name": "RayTrace", "value": 768.8485710000002}, {"lowerIsBetter": false, "replicates": [565.9309564233164], "unit": "score", "name": "Earley", "value": 1177.6401210000001}, {"lowerIsBetter": false, "replicates": [10691.489361702128], "unit": "score", "name": "Boyer", "value": 62.335842786069605}, {"lowerIsBetter": false, "replicates": [39509.80392156863], "unit": "score", "name": "RegExp", "value": 23.057188585607953}, {"lowerIsBetter": false, "replicates": [496.5312190287413], "unit": "score", "name": "Splay", "value": 164.12059680638725}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 22074.745390347103}]} 18:28:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "22074.75"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1473.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "6982.86"}}} 18:28:45 INFO - Return code: 0 18:28:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 18:28:45 INFO - # TBPL SUCCESS # 18:28:45 INFO - Running post-action listener: _resource_record_post_action 18:28:45 INFO - Running post-run listener: _resource_record_post_run 18:28:46 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 4096; Write bytes: 462577664; Read time: 12; Write time: 317092 18:28:46 INFO - install - Wall time: 13s; CPU: 14.0%; Read bytes: 0; Write bytes: 234356736; Read time: 0; Write time: 208316 18:28:46 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 4096; Write bytes: 227766272; Read time: 12; Write time: 108752 18:28:46 INFO - Running post-run listener: _upload_blobber_files 18:28:46 INFO - Blob upload gear active. 18:28:46 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 18:28:46 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 18:28:46 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'] 18:28:46 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 18:28:46 INFO - (blobuploader) - INFO - Open directory for files ... 18:28:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:28:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:28:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:28:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:28:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:28:47 INFO - (blobuploader) - INFO - Done attempting. 18:28:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 18:28:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:28:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:28:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:28:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:28:48 INFO - (blobuploader) - INFO - Done attempting. 18:28:48 INFO - (blobuploader) - INFO - Iteration through files over. 18:28:48 INFO - Return code: 0 18:28:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 18:28:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 18:28:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f5952fb20ded18db7d7fb657d1b0713f571b6b6c9a39f82642eaca68dbd7f6202e25375a6c0fdc341a8091b01c15335279d84e6f3c032ecaaa142a27493f39fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c8b6b2b79b207b5e0134905e849c58da152ffaf619a1d370aa4896c14adb94282f4c7b546d44365da52ca1a89fc7f984e6d46a11dd68514efc07c3cbe318ad2e"} 18:28:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 18:28:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 18:28:48 INFO - Contents: 18:28:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f5952fb20ded18db7d7fb657d1b0713f571b6b6c9a39f82642eaca68dbd7f6202e25375a6c0fdc341a8091b01c15335279d84e6f3c032ecaaa142a27493f39fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c8b6b2b79b207b5e0134905e849c58da152ffaf619a1d370aa4896c14adb94282f4c7b546d44365da52ca1a89fc7f984e6d46a11dd68514efc07c3cbe318ad2e"} 18:28:48 INFO - Running post-run listener: copy_logs_to_upload_dir 18:28:48 INFO - Copying logs to upload dir... 18:28:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 18:28:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.438819 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-03-24 18:28:48.784887) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 18:28:48.788689) ========= 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=337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742 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/f5952fb20ded18db7d7fb657d1b0713f571b6b6c9a39f82642eaca68dbd7f6202e25375a6c0fdc341a8091b01c15335279d84e6f3c032ecaaa142a27493f39fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c8b6b2b79b207b5e0134905e849c58da152ffaf619a1d370aa4896c14adb94282f4c7b546d44365da52ca1a89fc7f984e6d46a11dd68514efc07c3cbe318ad2e"} build_url:https://queue.taskcluster.net/v1/task/U1u41wmtTbK0lb_4geKIVw/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011311 build_url: 'https://queue.taskcluster.net/v1/task/U1u41wmtTbK0lb_4geKIVw/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/f5952fb20ded18db7d7fb657d1b0713f571b6b6c9a39f82642eaca68dbd7f6202e25375a6c0fdc341a8091b01c15335279d84e6f3c032ecaaa142a27493f39fd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/c8b6b2b79b207b5e0134905e849c58da152ffaf619a1d370aa4896c14adb94282f4c7b546d44365da52ca1a89fc7f984e6d46a11dd68514efc07c3cbe318ad2e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 18:28:48.813579) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 18:28:48.813903) ========= 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=337fe3f4b1febe37b85fccc40000019e-1458867972.571944-1560358742 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 18:28:48.898092) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 18:28:48.898415) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 18:28:48.898732) ========= ========= Total master_lag: 0.28 =========