builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-009 starttime: 1458762999.58 results: success (0) buildid: 20160323102017 builduid: 79cd8a1a108a4f54a7483d874cef4a23 revision: c93a1ee478a39897eeac3d200cb522d1e5f7df84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:39.578836) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:39.579303) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:39.579702) ========= 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=aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006513 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:39.614500) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:39.614819) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:39.643953) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:39.644242) ========= 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=aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:39.702878) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:39.703171) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:39.703555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:39.703931) ========= 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=aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-23 12:56:39-- 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% 32.9M=0s 2016-03-23 12:56:40 (32.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.331823 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:40.051060) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:40.051391) ========= 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=aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016201 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:40.101368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:40.101730) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c93a1ee478a39897eeac3d200cb522d1e5f7df84 --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 c93a1ee478a39897eeac3d200cb522d1e5f7df84 --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=aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-23 12:56:40,433 truncating revision to first 12 chars 2016-03-23 12:56:40,434 Setting DEBUG logging. 2016-03-23 12:56:40,434 attempt 1/10 2016-03-23 12:56:40,434 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c93a1ee478a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-23 12:56:40,694 unpacking tar archive at: mozilla-beta-c93a1ee478a3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.574716 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:40.689347) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:40.689706) ========= echo c93a1ee478a39897eeac3d200cb522d1e5f7df84 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'c93a1ee478a39897eeac3d200cb522d1e5f7df84'] 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=aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False c93a1ee478a39897eeac3d200cb522d1e5f7df84 program finished with exit code 0 elapsedTime=0.004507 script_repo_revision: 'c93a1ee478a39897eeac3d200cb522d1e5f7df84' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:40.743859) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:40.744342) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 12:56:40.756047) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-23 12:56:40.756696) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:56:41 INFO - MultiFileLogger online at 20160323 12:56:41 in /builds/slave/test-pgo 12:56:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:56:41 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:56:41 INFO - {'append_to_log': False, 12:56:41 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:56:41 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:56:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:56:41 INFO - 'branch': 'Mozilla-Beta', 12:56:41 INFO - 'buildbot_json_path': 'buildprops.json', 12:56:41 INFO - 'config_files': ('talos/linux_config.py',), 12:56:41 INFO - 'default_actions': ('clobber', 12:56:41 INFO - 'read-buildbot-config', 12:56:41 INFO - 'download-and-extract', 12:56:41 INFO - 'populate-webroot', 12:56:41 INFO - 'create-virtualenv', 12:56:41 INFO - 'install', 12:56:41 INFO - 'run-tests'), 12:56:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:56:41 INFO - 'download_minidump_stackwalk': True, 12:56:41 INFO - 'download_symbols': 'ondemand', 12:56:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:56:41 INFO - 'tooltool.py': '/tools/tooltool.py', 12:56:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:56:41 INFO - '/tools/misc-python/virtualenv.py')}, 12:56:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:56:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:56:41 INFO - 'installer_path': 'installer.exe', 12:56:41 INFO - 'log_level': 'info', 12:56:41 INFO - 'log_name': 'talos', 12:56:41 INFO - 'log_to_console': True, 12:56:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:56:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:56:41 INFO - 'opt_config_files': (), 12:56:41 INFO - 'pip_index': False, 12:56:41 INFO - 'sps_profile': False, 12:56:41 INFO - 'sps_profile_interval': 0, 12:56:41 INFO - 'suite': 'dromaeojs-e10s', 12:56:41 INFO - 'system_bits': '32', 12:56:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:56:41 INFO - 'title': 'talos-linux64-ix-009', 12:56:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:56:41 INFO - 'use_talos_json': True, 12:56:41 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:56:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:56:41 INFO - 'work_dir': 'build'} 12:56:41 INFO - ##### 12:56:41 INFO - ##### Running clobber step. 12:56:41 INFO - ##### 12:56:41 INFO - Running pre-action listener: _resource_record_pre_action 12:56:41 INFO - Running main action method: clobber 12:56:41 INFO - rmtree: /builds/slave/test-pgo/build 12:56:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:56:41 INFO - Running post-action listener: _resource_record_post_action 12:56:41 INFO - ##### 12:56:41 INFO - ##### Running read-buildbot-config step. 12:56:41 INFO - ##### 12:56:41 INFO - Running pre-action listener: _resource_record_pre_action 12:56:41 INFO - Running main action method: read_buildbot_config 12:56:41 INFO - Using buildbot properties: 12:56:41 INFO - { 12:56:41 INFO - "project": "", 12:56:41 INFO - "product": "firefox", 12:56:41 INFO - "script_repo_revision": "production", 12:56:41 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 12:56:41 INFO - "repository": "", 12:56:41 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 12:56:41 INFO - "buildid": "20160323102017", 12:56:41 INFO - "pgo_build": "True", 12:56:41 INFO - "basedir": "/builds/slave/test-pgo", 12:56:41 INFO - "buildnumber": 26, 12:56:41 INFO - "slavename": "talos-linux64-ix-009", 12:56:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:56:41 INFO - "platform": "ubuntu64_hw", 12:56:41 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:56:41 INFO - "branch": "mozilla-beta", 12:56:41 INFO - "repo_path": "releases/mozilla-beta", 12:56:41 INFO - "revision": "c93a1ee478a39897eeac3d200cb522d1e5f7df84", 12:56:41 INFO - "stage_platform": "linux64-pgo", 12:56:41 INFO - "builduid": "79cd8a1a108a4f54a7483d874cef4a23", 12:56:41 INFO - "slavebuilddir": "test" 12:56:41 INFO - } 12:56:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 12:56:41 INFO - Running post-action listener: _resource_record_post_action 12:56:41 INFO - ##### 12:56:41 INFO - ##### Running download-and-extract step. 12:56:41 INFO - ##### 12:56:41 INFO - Running pre-action listener: _resource_record_pre_action 12:56:41 INFO - Running main action method: download_and_extract 12:56:41 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:56:41 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')]} 12:56:41 INFO - https://queue.taskcluster.net/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:56:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/test_packages.json 12:56:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/test_packages.json 12:56:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:56:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:56:46 INFO - Downloaded 1412 bytes. 12:56:46 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:56:46 INFO - Using the following test package requirements: 12:56:46 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:56:46 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:56:46 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:56:46 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:56:46 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 12:56:46 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:56:46 INFO - u'jsshell-linux-x86_64.zip'], 12:56:46 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:56:46 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:56:46 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:56:46 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:56:46 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 12:56:46 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:56:46 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 12:56:46 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:56:46 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:56:46 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:56:46 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:56:46 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:56:46 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:56:46 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')]} 12:56:46 INFO - https://queue.taskcluster.net/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:56:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:56:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:56:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/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 12:56:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/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 12:56:47 INFO - Downloaded 23107418 bytes. 12:56:47 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'] 12:56:47 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 12:56:49 INFO - Return code: 0 12:56:49 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 12:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:49 INFO - https://queue.taskcluster.net/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:56:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:56:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:56:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/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 12:56:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/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 12:56:53 INFO - Downloaded 23107418 bytes. 12:56:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:56:53 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 12:56:54 INFO - Return code: 0 12:56: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')]} 12:56:54 INFO - https://queue.taskcluster.net/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:56:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 12:56:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 12:56:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/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 12:56:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/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 12:56:56 INFO - Downloaded 10801548 bytes. 12:56:56 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'] 12:56:56 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 12:56:56 INFO - Return code: 0 12:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:56 INFO - https://queue.taskcluster.net/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:56:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:56:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:56:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/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 12:56:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/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 12:56:57 INFO - Downloaded 52861761 bytes. 12:56:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:56:57 INFO - mkdir: /builds/slave/test-pgo/properties 12:56:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:56:57 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:56:57 INFO - Contents: 12:56:57 INFO - build_url:https://queue.taskcluster.net/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:56:58 INFO - Running post-action listener: _resource_record_post_action 12:56:58 INFO - Running post-action listener: set_extra_try_arguments 12:56:58 INFO - ##### 12:56:58 INFO - ##### Running populate-webroot step. 12:56:58 INFO - ##### 12:56:58 INFO - Running pre-action listener: _resource_record_pre_action 12:56:58 INFO - Running main action method: populate_webroot 12:56:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:56:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:56:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:56:58 INFO - '--tppagecycles', 12:56:58 INFO - '7'], 12:56:58 INFO - 'tests': ['tsvgm']}}, 12:56:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:56:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:56:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:56:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:56:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:56:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:56:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:56:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:58 INFO - 'talos_options': ['--e10s'], 12:56:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:56:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:58 INFO - 'tests': ['damp', 'tps']}, 12:56:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:58 INFO - 'talos_options': ['--e10s'], 12:56:58 INFO - 'tests': ['damp', 'tps']}, 12:56:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:56:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:56:58 INFO - 'other': {'tests': ['a11yr', 12:56:58 INFO - 'ts_paint', 12:56:58 INFO - 'tpaint', 12:56:58 INFO - 'sessionrestore', 12:56:58 INFO - 'sessionrestore_no_auto_restore']}, 12:56:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:56:58 INFO - 'tests': ['a11yr', 12:56:58 INFO - 'ts_paint', 12:56:58 INFO - 'tpaint', 12:56:58 INFO - 'sessionrestore', 12:56:58 INFO - 'sessionrestore_no_auto_restore']}, 12:56:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:56:58 INFO - 'tests': ['a11yr', 12:56:58 INFO - 'ts_paint', 12:56:58 INFO - 'tpaint', 12:56:58 INFO - 'sessionrestore', 12:56:58 INFO - 'sessionrestore_no_auto_restore']}, 12:56:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:56:58 INFO - 'tests': ['a11yr', 12:56:58 INFO - 'ts_paint', 12:56:58 INFO - 'tpaint', 12:56:58 INFO - 'sessionrestore', 12:56:58 INFO - 'sessionrestore_no_auto_restore']}, 12:56:58 INFO - 'other_l64': {'tests': ['a11yr', 12:56:58 INFO - 'ts_paint', 12:56:58 INFO - 'tpaint', 12:56:58 INFO - 'sessionrestore', 12:56:58 INFO - 'sessionrestore_no_auto_restore']}, 12:56:58 INFO - 'other_nol64': {'tests': ['a11yr', 12:56:58 INFO - 'ts_paint', 12:56:58 INFO - 'tpaint', 12:56:58 INFO - 'sessionrestore', 12:56:58 INFO - 'sessionrestore_no_auto_restore']}, 12:56:58 INFO - 'svgr': {'tests': ['tsvgx', 12:56:58 INFO - 'tsvgr_opacity', 12:56:58 INFO - 'tart', 12:56:58 INFO - 'tscrollx', 12:56:58 INFO - 'cart']}, 12:56:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:56:58 INFO - 'tests': ['tsvgx', 12:56:58 INFO - 'tsvgr_opacity', 12:56:58 INFO - 'tart', 12:56:58 INFO - 'tscrollx', 12:56:58 INFO - 'cart']}, 12:56:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:58 INFO - 'tests': ['tp5o']}, 12:56:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:58 INFO - 'talos_options': ['--e10s'], 12:56:58 INFO - 'tests': ['tp5o']}, 12:56:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:58 INFO - 'talos_options': ['--xperf_path', 12:56:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:56:58 INFO - 'tests': ['tp5n']}, 12:56:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:58 INFO - 'talos_options': ['--e10s', 12:56:58 INFO - '--xperf_path', 12:56:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:56:58 INFO - 'tests': ['tp5n']}}, 12:56:58 INFO - 'talos.zip': {'path': '', 12:56:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:56:58 INFO - Running post-action listener: _resource_record_post_action 12:56:58 INFO - ##### 12:56:58 INFO - ##### Running create-virtualenv step. 12:56:58 INFO - ##### 12:56:58 INFO - Running pre-action listener: _resource_record_pre_action 12:56:58 INFO - Running main action method: create_virtualenv 12:56:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:56:58 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 12:56:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:56:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:56:58 INFO - Using real prefix '/usr' 12:56:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:56:59 INFO - Installing distribute.............................................................................................................................................................................................done. 12:57:00 INFO - Installing pip.................done. 12:57:01 INFO - Return code: 0 12:57:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2671141f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19dc4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b6c0>, '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 0x1a6c5c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ca70>, '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': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', '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 12:57:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 12:57:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:57:01 INFO - Using env: {'DISPLAY': ':0', 12:57:01 INFO - 'HOME': '/home/cltbld', 12:57:01 INFO - 'LANG': 'en_US.UTF-8', 12:57:01 INFO - 'LANGUAGE': 'en_US:en', 12:57:01 INFO - 'LOGNAME': 'cltbld', 12:57:01 INFO - 'MAIL': '/var/mail/cltbld', 12:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:01 INFO - 'MOZ_NO_REMOTE': '1', 12:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:01 INFO - 'NO_EM_RESTART': '1', 12:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:01 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:01 INFO - 'SHELL': '/bin/bash', 12:57:01 INFO - 'SHLVL': '1', 12:57:01 INFO - 'TERM': 'linux', 12:57:01 INFO - 'TMOUT': '86400', 12:57:01 INFO - 'USER': 'cltbld', 12:57:01 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', 12:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:01 INFO - '_': '/tools/buildbot/bin/python'} 12:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:01 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 12:57:01 INFO - Cleaning up... 12:57:01 INFO - Return code: 0 12:57:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2671141f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19dc4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b6c0>, '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 0x1a6c5c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ca70>, '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': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', '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 12:57:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 12:57:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:57:01 INFO - Using env: {'DISPLAY': ':0', 12:57:01 INFO - 'HOME': '/home/cltbld', 12:57:01 INFO - 'LANG': 'en_US.UTF-8', 12:57:01 INFO - 'LANGUAGE': 'en_US:en', 12:57:01 INFO - 'LOGNAME': 'cltbld', 12:57:01 INFO - 'MAIL': '/var/mail/cltbld', 12:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:01 INFO - 'MOZ_NO_REMOTE': '1', 12:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:01 INFO - 'NO_EM_RESTART': '1', 12:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:01 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:01 INFO - 'SHELL': '/bin/bash', 12:57:01 INFO - 'SHLVL': '1', 12:57:01 INFO - 'TERM': 'linux', 12:57:01 INFO - 'TMOUT': '86400', 12:57:01 INFO - 'USER': 'cltbld', 12:57:01 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', 12:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:01 INFO - '_': '/tools/buildbot/bin/python'} 12:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:01 INFO - Downloading/unpacking psutil>=0.7.1 12:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:57:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:57:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:57:03 INFO - Installing collected packages: psutil 12:57:03 INFO - Running setup.py install for psutil 12:57:03 INFO - building 'psutil._psutil_linux' extension 12:57:03 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 12:57: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:57:03 INFO - building 'psutil._psutil_posix' extension 12:57:03 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 12:57: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 12:57:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:57:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:57:03 INFO - Successfully installed psutil 12:57:03 INFO - Cleaning up... 12:57:04 INFO - Return code: 0 12:57:04 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:57:04 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')]} 12:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:04 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')]} 12:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:04 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 0x7f2671141f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19dc4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b6c0>, '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 0x1a6c5c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ca70>, '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': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', '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 12:57:04 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 12:57:04 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 12:57:04 INFO - Using env: {'DISPLAY': ':0', 12:57:04 INFO - 'HOME': '/home/cltbld', 12:57:04 INFO - 'LANG': 'en_US.UTF-8', 12:57:04 INFO - 'LANGUAGE': 'en_US:en', 12:57:04 INFO - 'LOGNAME': 'cltbld', 12:57:04 INFO - 'MAIL': '/var/mail/cltbld', 12:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:04 INFO - 'MOZ_NO_REMOTE': '1', 12:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:04 INFO - 'NO_EM_RESTART': '1', 12:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:04 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:04 INFO - 'SHELL': '/bin/bash', 12:57:04 INFO - 'SHLVL': '1', 12:57:04 INFO - 'TERM': 'linux', 12:57:04 INFO - 'TMOUT': '86400', 12:57:04 INFO - 'USER': 'cltbld', 12:57:04 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', 12:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:04 INFO - '_': '/tools/buildbot/bin/python'} 12:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:06 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:57:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:57:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:57:06 INFO - Installing collected packages: mozsystemmonitor 12:57:06 INFO - Running setup.py install for mozsystemmonitor 12:57:06 INFO - Successfully installed mozsystemmonitor 12:57:06 INFO - Cleaning up... 12:57:06 INFO - Return code: 0 12:57:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2671141f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19dc4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b6c0>, '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 0x1a6c5c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ca70>, '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': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', '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 12:57:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 12:57:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:57:06 INFO - Using env: {'DISPLAY': ':0', 12:57:06 INFO - 'HOME': '/home/cltbld', 12:57:06 INFO - 'LANG': 'en_US.UTF-8', 12:57:06 INFO - 'LANGUAGE': 'en_US:en', 12:57:06 INFO - 'LOGNAME': 'cltbld', 12:57:06 INFO - 'MAIL': '/var/mail/cltbld', 12:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:06 INFO - 'MOZ_NO_REMOTE': '1', 12:57:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:06 INFO - 'NO_EM_RESTART': '1', 12:57:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:06 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:06 INFO - 'SHELL': '/bin/bash', 12:57:06 INFO - 'SHLVL': '1', 12:57:06 INFO - 'TERM': 'linux', 12:57:06 INFO - 'TMOUT': '86400', 12:57:06 INFO - 'USER': 'cltbld', 12:57:06 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', 12:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:06 INFO - '_': '/tools/buildbot/bin/python'} 12:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:06 INFO - Downloading/unpacking blobuploader==1.2.4 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:08 INFO - Downloading blobuploader-1.2.4.tar.gz 12:57:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:57:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:57:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:09 INFO - Downloading docopt-0.6.1.tar.gz 12:57:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:57:09 INFO - Installing collected packages: blobuploader, requests, docopt 12:57:09 INFO - Running setup.py install for blobuploader 12:57:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:57:09 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:57:09 INFO - Running setup.py install for requests 12:57:09 INFO - Running setup.py install for docopt 12:57:09 INFO - Successfully installed blobuploader requests docopt 12:57:09 INFO - Cleaning up... 12:57:09 INFO - Return code: 0 12:57:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:57:09 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')]} 12:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:09 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')]} 12:57:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:09 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 0x7f2671141f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19dc4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b6c0>, '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 0x1a6c5c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ca70>, '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': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', '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 12:57:09 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 12:57:09 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 12:57:09 INFO - Using env: {'DISPLAY': ':0', 12:57:09 INFO - 'HOME': '/home/cltbld', 12:57:09 INFO - 'LANG': 'en_US.UTF-8', 12:57:09 INFO - 'LANGUAGE': 'en_US:en', 12:57:09 INFO - 'LOGNAME': 'cltbld', 12:57:09 INFO - 'MAIL': '/var/mail/cltbld', 12:57:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:09 INFO - 'MOZ_NO_REMOTE': '1', 12:57:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:09 INFO - 'NO_EM_RESTART': '1', 12:57:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:09 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:09 INFO - 'SHELL': '/bin/bash', 12:57:09 INFO - 'SHLVL': '1', 12:57:09 INFO - 'TERM': 'linux', 12:57:09 INFO - 'TMOUT': '86400', 12:57:09 INFO - 'USER': 'cltbld', 12:57:09 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', 12:57:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:09 INFO - '_': '/tools/buildbot/bin/python'} 12:57:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:57:09 INFO - Running setup.py (path:/tmp/pip-uOhN1k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:57:10 INFO - Running setup.py (path:/tmp/pip-6V8bpU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:57:10 INFO - Running setup.py (path:/tmp/pip-H9RMWU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:57:10 INFO - Running setup.py (path:/tmp/pip-EmA9DP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:57:10 INFO - Running setup.py (path:/tmp/pip-SR79nv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:57:10 INFO - Running setup.py (path:/tmp/pip-07mntF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:57:10 INFO - Running setup.py (path:/tmp/pip-v91FB3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:57:10 INFO - Running setup.py (path:/tmp/pip-Jk6lKB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:57:10 INFO - Running setup.py (path:/tmp/pip-GKvMym-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:57:10 INFO - Running setup.py (path:/tmp/pip-uqduSC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:57:10 INFO - Running setup.py (path:/tmp/pip-UZEfM6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:57:10 INFO - Running setup.py (path:/tmp/pip-FInxQ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:57:10 INFO - Running setup.py (path:/tmp/pip-ogY33R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:57:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:57:10 INFO - Running setup.py (path:/tmp/pip-HTqbYL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:57:11 INFO - Running setup.py (path:/tmp/pip-iTeoEF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:57:11 INFO - Running setup.py (path:/tmp/pip-VCBK9E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:57:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:57:11 INFO - Running setup.py (path:/tmp/pip-BSK15h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:57:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:57:11 INFO - Running setup.py install for manifestparser 12:57:11 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:57:11 INFO - Running setup.py install for mozcrash 12:57:11 INFO - Running setup.py install for mozdebug 12:57:11 INFO - Running setup.py install for mozdevice 12:57:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:57:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:57:11 INFO - Running setup.py install for mozfile 12:57:11 INFO - Running setup.py install for mozhttpd 12:57:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:57:11 INFO - Running setup.py install for mozinfo 12:57:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:57:11 INFO - Running setup.py install for mozInstall 12:57:12 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:57:12 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:57:12 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:57:12 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:57:12 INFO - Running setup.py install for mozleak 12:57:12 INFO - Running setup.py install for mozlog 12:57:12 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:57:12 INFO - Running setup.py install for moznetwork 12:57:12 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:57:12 INFO - Running setup.py install for mozprocess 12:57:12 INFO - Running setup.py install for mozprofile 12:57:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:57:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:57:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:57:12 INFO - Running setup.py install for mozrunner 12:57:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:57:12 INFO - Running setup.py install for mozscreenshot 12:57:12 INFO - Running setup.py install for moztest 12:57:12 INFO - Running setup.py install for mozversion 12:57:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:57:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:57:12 INFO - Cleaning up... 12:57:12 INFO - Return code: 0 12:57:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:57: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')]} 12:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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 0x7f2671141f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19dc4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b6c0>, '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 0x1a6c5c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ca70>, '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': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', '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 12:57: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 12:57: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 12:57:12 INFO - Using env: {'DISPLAY': ':0', 12:57:12 INFO - 'HOME': '/home/cltbld', 12:57:12 INFO - 'LANG': 'en_US.UTF-8', 12:57:12 INFO - 'LANGUAGE': 'en_US:en', 12:57:12 INFO - 'LOGNAME': 'cltbld', 12:57:12 INFO - 'MAIL': '/var/mail/cltbld', 12:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:12 INFO - 'MOZ_NO_REMOTE': '1', 12:57:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:12 INFO - 'NO_EM_RESTART': '1', 12:57:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:12 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:12 INFO - 'SHELL': '/bin/bash', 12:57:12 INFO - 'SHLVL': '1', 12:57:12 INFO - 'TERM': 'linux', 12:57:12 INFO - 'TMOUT': '86400', 12:57:13 INFO - 'USER': 'cltbld', 12:57:13 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', 12:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:13 INFO - '_': '/tools/buildbot/bin/python'} 12:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:57:13 INFO - Running setup.py (path:/tmp/pip-rchbDh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:57:13 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)) 12:57:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:57:13 INFO - Running setup.py (path:/tmp/pip-p5vfot-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:57:13 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)) 12:57:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:57:13 INFO - Running setup.py (path:/tmp/pip-6Vz4wy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:57:13 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)) 12:57:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:57:13 INFO - Running setup.py (path:/tmp/pip-cGkEdB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:57:13 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)) 12:57:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:57:13 INFO - Running setup.py (path:/tmp/pip-bP0iIm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:57:13 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)) 12:57:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:57:13 INFO - Running setup.py (path:/tmp/pip-nDojmj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:57:13 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)) 12:57:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:57:13 INFO - Running setup.py (path:/tmp/pip-MuoZO5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:57:13 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)) 12:57:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:57:13 INFO - Running setup.py (path:/tmp/pip-hODZq0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:57:13 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)) 12:57:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:57:13 INFO - Running setup.py (path:/tmp/pip-ghx5SN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:57: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)) 12:57:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:57:13 INFO - Running setup.py (path:/tmp/pip-5N0kN2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:57: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)) 12:57:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:57:13 INFO - Running setup.py (path:/tmp/pip-HEmHm6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:57: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)) 12:57:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:57:13 INFO - Running setup.py (path:/tmp/pip-60kQyu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:57:14 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)) 12:57:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:57:14 INFO - Running setup.py (path:/tmp/pip-4fzqFS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:57:14 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)) 12:57:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:57:14 INFO - Running setup.py (path:/tmp/pip-3LyyTv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:57:14 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)) 12:57:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:57:14 INFO - Running setup.py (path:/tmp/pip-MNRO0p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:57:14 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)) 12:57:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:57:14 INFO - Running setup.py (path:/tmp/pip-Jyx34L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:57:14 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)) 12:57:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:57:14 INFO - Running setup.py (path:/tmp/pip-DROAw1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:57:14 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)) 12:57:14 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)) 12:57:14 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)) 12:57:14 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)) 12:57:14 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)) 12:57:14 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)) 12:57:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:16 INFO - Downloading blessings-1.6.tar.gz 12:57:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:57:16 INFO - Installing collected packages: blessings 12:57:16 INFO - Running setup.py install for blessings 12:57:16 INFO - Successfully installed blessings 12:57:16 INFO - Cleaning up... 12:57:16 INFO - Return code: 0 12:57:16 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:57:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:57:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:57:16 INFO - Reading from file tmpfile_stdout 12:57:16 INFO - Current package versions: 12:57:16 INFO - argparse == 1.2.1 12:57:16 INFO - blessings == 1.6 12:57:16 INFO - blobuploader == 1.2.4 12:57:16 INFO - docopt == 0.6.1 12:57:16 INFO - manifestparser == 1.1 12:57:16 INFO - mozInstall == 1.12 12:57:16 INFO - mozcrash == 0.16 12:57:16 INFO - mozdebug == 0.1 12:57:16 INFO - mozdevice == 0.48 12:57:16 INFO - mozfile == 1.2 12:57:16 INFO - mozhttpd == 0.7 12:57:16 INFO - mozinfo == 0.9 12:57:16 INFO - mozleak == 0.1 12:57:16 INFO - mozlog == 3.1 12:57:16 INFO - moznetwork == 0.27 12:57:16 INFO - mozprocess == 0.22 12:57:16 INFO - mozprofile == 0.28 12:57:16 INFO - mozrunner == 6.11 12:57:16 INFO - mozscreenshot == 0.1 12:57:16 INFO - mozsystemmonitor == 0.0 12:57:16 INFO - moztest == 0.7 12:57:16 INFO - mozversion == 1.4 12:57:16 INFO - psutil == 3.1.1 12:57:16 INFO - requests == 1.2.3 12:57:16 INFO - wsgiref == 0.1.2 12:57:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:57: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')]} 12:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57: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')]} 12:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:16 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 0x7f2671141f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19dc4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b6c0>, '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 0x1a6c5c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ca70>, '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': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', '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 12:57:16 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 12:57:16 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 12:57:16 INFO - Using env: {'DISPLAY': ':0', 12:57:16 INFO - 'HOME': '/home/cltbld', 12:57:16 INFO - 'LANG': 'en_US.UTF-8', 12:57:16 INFO - 'LANGUAGE': 'en_US:en', 12:57:16 INFO - 'LOGNAME': 'cltbld', 12:57:16 INFO - 'MAIL': '/var/mail/cltbld', 12:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:16 INFO - 'MOZ_NO_REMOTE': '1', 12:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:16 INFO - 'NO_EM_RESTART': '1', 12:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:16 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:16 INFO - 'SHELL': '/bin/bash', 12:57:16 INFO - 'SHLVL': '1', 12:57:16 INFO - 'TERM': 'linux', 12:57:16 INFO - 'TMOUT': '86400', 12:57:16 INFO - 'USER': 'cltbld', 12:57:16 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', 12:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:16 INFO - '_': '/tools/buildbot/bin/python'} 12:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57: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)) 12:57: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)) 12:57: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)) 12:57: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)) 12:57: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)) 12:57: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)) 12:57: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)) 12:57: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)) 12:57: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)) 12:57: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)) 12:57: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)) 12:57:16 INFO - Cleaning up... 12:57:17 INFO - Return code: 0 12:57:17 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:57:17 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')]} 12:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:17 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')]} 12:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:17 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 0x7f2671141f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19dc4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b6c0>, '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 0x1a6c5c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ca70>, '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': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', '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 12:57:17 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 12:57:17 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 12:57:17 INFO - Using env: {'DISPLAY': ':0', 12:57:17 INFO - 'HOME': '/home/cltbld', 12:57:17 INFO - 'LANG': 'en_US.UTF-8', 12:57:17 INFO - 'LANGUAGE': 'en_US:en', 12:57:17 INFO - 'LOGNAME': 'cltbld', 12:57:17 INFO - 'MAIL': '/var/mail/cltbld', 12:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:17 INFO - 'MOZ_NO_REMOTE': '1', 12:57:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:17 INFO - 'NO_EM_RESTART': '1', 12:57:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:17 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:17 INFO - 'SHELL': '/bin/bash', 12:57:17 INFO - 'SHLVL': '1', 12:57:17 INFO - 'TERM': 'linux', 12:57:17 INFO - 'TMOUT': '86400', 12:57:17 INFO - 'USER': 'cltbld', 12:57:17 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', 12:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:17 INFO - '_': '/tools/buildbot/bin/python'} 12:57:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:17 INFO - Downloading/unpacking jsonschema 12:57:17 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 12:57:17 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 12:57:17 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 12:57:17 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 12:57:17 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 12:57:17 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 12:57:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:57:19 INFO - Downloading/unpacking functools32 (from jsonschema) 12:57:19 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 12:57:19 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 12:57:19 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 12:57:19 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 12:57:19 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 12:57:19 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 12:57:19 INFO - Downloading functools32-3.2.3-2.tar.gz 12:57:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:57:19 INFO - warning: no files found matching '*.txt' 12:57:19 INFO - no previously-included directories found matching 'build' 12:57:19 INFO - no previously-included directories found matching 'dist' 12:57:19 INFO - no previously-included directories found matching '.git*' 12:57:19 INFO - Installing collected packages: jsonschema, functools32 12:57:19 INFO - Running setup.py install for functools32 12:57:19 INFO - warning: no files found matching '*.txt' 12:57:19 INFO - no previously-included directories found matching 'build' 12:57:19 INFO - no previously-included directories found matching 'dist' 12:57:19 INFO - no previously-included directories found matching '.git*' 12:57:19 INFO - Successfully installed jsonschema functools32 12:57:19 INFO - Cleaning up... 12:57:19 INFO - Return code: 0 12:57:19 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:19 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 0x7f2671141f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x190f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19dc4e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a6b6c0>, '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 0x1a6c5c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ca70>, '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': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', '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 12:57:19 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 12:57:19 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 12:57:19 INFO - Using env: {'DISPLAY': ':0', 12:57:19 INFO - 'HOME': '/home/cltbld', 12:57:19 INFO - 'LANG': 'en_US.UTF-8', 12:57:19 INFO - 'LANGUAGE': 'en_US:en', 12:57:19 INFO - 'LOGNAME': 'cltbld', 12:57:19 INFO - 'MAIL': '/var/mail/cltbld', 12:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:19 INFO - 'MOZ_NO_REMOTE': '1', 12:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:19 INFO - 'NO_EM_RESTART': '1', 12:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:19 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:19 INFO - 'SHELL': '/bin/bash', 12:57:19 INFO - 'SHLVL': '1', 12:57:19 INFO - 'TERM': 'linux', 12:57:19 INFO - 'TMOUT': '86400', 12:57:19 INFO - 'USER': 'cltbld', 12:57:19 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', 12:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:19 INFO - '_': '/tools/buildbot/bin/python'} 12:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:19 INFO - Downloading/unpacking flake8 12:57:19 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 12:57:19 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 12:57:19 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 12:57:19 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 12:57:19 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 12:57:19 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 12:57:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:57:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:57:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57: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 12:57:22 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:57:22 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 12:57:22 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 12:57:22 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 12:57:22 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 12:57:22 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 12:57:22 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 12:57:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:57:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:57:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:57:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:57:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:57:22 INFO - no previously-included directories found matching 'docs/_build' 12:57:22 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:57:22 INFO - Running setup.py install for pep8 12:57:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:57:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:57:22 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:57:22 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:57:22 INFO - no previously-included directories found matching 'docs/_build' 12:57:22 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:57:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:57:22 INFO - Cleaning up... 12:57:22 INFO - Return code: 0 12:57:22 INFO - Running post-action listener: _resource_record_post_action 12:57:22 INFO - Running post-action listener: _start_resource_monitoring 12:57:22 INFO - Starting resource monitoring. 12:57:22 INFO - ##### 12:57:22 INFO - ##### Running install step. 12:57:22 INFO - ##### 12:57:22 INFO - Running pre-action listener: _resource_record_pre_action 12:57:22 INFO - Running main action method: install 12:57:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:57:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:57:22 INFO - Reading from file tmpfile_stdout 12:57:22 INFO - Detecting whether we're running mozinstall >=1.0... 12:57:22 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:57:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:57:22 INFO - Reading from file tmpfile_stdout 12:57:22 INFO - Output received: 12:57:22 INFO - Usage: mozinstall [options] installer 12:57:22 INFO - Options: 12:57:22 INFO - -h, --help show this help message and exit 12:57:22 INFO - -d DEST, --destination=DEST 12:57:22 INFO - Directory to install application into. [default: 12:57:22 INFO - "/builds/slave/test-pgo"] 12:57:22 INFO - --app=APP Application being installed. [default: firefox] 12:57:22 INFO - mkdir: /builds/slave/test-pgo/build/application 12:57: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'] 12:57: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 12:57:35 INFO - Reading from file tmpfile_stdout 12:57:35 INFO - Output received: 12:57:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:57:35 INFO - Running post-action listener: _resource_record_post_action 12:57:35 INFO - ##### 12:57:35 INFO - ##### Running run-tests step. 12:57:35 INFO - ##### 12:57:35 INFO - Running pre-action listener: _resource_record_pre_action 12:57:35 INFO - Running main action method: run_tests 12:57:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:57:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:57:35 INFO - Python 2.7.3 12:57:35 INFO - Return code: 0 12:57:35 INFO - grabbing minidump binary from tooltool 12:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:35 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 0x1a6b6c0>, '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 0x1a6c5c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a6ca70>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:57:35 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 12:57:35 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 12:57:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:57:35 INFO - Return code: 0 12:57:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:57:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:57:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:57:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:57:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:57:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:57:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:57:36 INFO - Return code: 0 12:57:36 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 12:57:36 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-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:57:36 INFO - Using env: {'DISPLAY': ':0', 12:57:36 INFO - 'HOME': '/home/cltbld', 12:57:36 INFO - 'LANG': 'en_US.UTF-8', 12:57:36 INFO - 'LANGUAGE': 'en_US:en', 12:57:36 INFO - 'LOGNAME': 'cltbld', 12:57:36 INFO - 'MAIL': '/var/mail/cltbld', 12:57:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:57:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:36 INFO - 'MOZ_NO_REMOTE': '1', 12:57:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:57:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:36 INFO - 'NO_EM_RESTART': '1', 12:57:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:36 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:57:36 INFO - 'SHELL': '/bin/bash', 12:57:36 INFO - 'SHLVL': '1', 12:57:36 INFO - 'TERM': 'linux', 12:57:36 INFO - 'TMOUT': '86400', 12:57:36 INFO - 'USER': 'cltbld', 12:57:36 INFO - 'XDG_SESSION_COOKIE': 'aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565', 12:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:36 INFO - '_': '/tools/buildbot/bin/python'} 12:57:36 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-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:57:36 INFO - mozversion application_buildid: 20160323102017 12:57:36 INFO - mozversion application_changeset: c93a1ee478a39897eeac3d200cb522d1e5f7df84 12:57:36 INFO - mozversion application_display_name: Firefox 12:57:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:57:36 INFO - mozversion application_name: Firefox 12:57:36 INFO - mozversion application_remotingname: firefox 12:57:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:57:36 INFO - mozversion application_vendor: Mozilla 12:57:36 INFO - mozversion application_version: 46.0 12:57:36 INFO - mozversion platform_buildid: 20160323102017 12:57:36 INFO - mozversion platform_changeset: c93a1ee478a39897eeac3d200cb522d1e5f7df84 12:57:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:57:36 INFO - mozversion platform_version: 46.0 12:57:36 INFO - using testdate: 1458763056 12:57:36 INFO - actual date: 1458763056 12:57:36 INFO - starting webserver on 'localhost:42510' 12:57:36 INFO - SUITE-START | Running 3 tests 12:57:36 INFO - TEST-START | dromaeo_css 12:57:36 INFO - operating with platform_type : linux_ 12:57:36 INFO - Initialising browser for dromaeo_css test... 12:57:36 INFO - TEST-INFO | started process 16086 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjTox7X/profile http://localhost:42510/getInfo.html) 12:57:40 INFO - PROCESS | 16086 | 12:57:40 INFO - PROCESS | 16086 | (process:16162): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:57:41 INFO - PROCESS | 16086 | __metrics Screen width/height:1600/1200 12:57:41 INFO - PROCESS | 16086 | colorDepth:24 12:57:41 INFO - PROCESS | 16086 | Browser inner width/height: 1024/697 12:57:41 INFO - PROCESS | 16086 | __metrics 12:57:42 INFO - TEST-INFO | 16086: exit 0 12:57:42 INFO - Browser initialized. 12:57:42 INFO - Running cycle 1/1 for dromaeo_css test... 12:57:42 INFO - TEST-INFO | started process 16210 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjTox7X/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:57:43 INFO - PROCESS | 16210 | 12:57:43 INFO - PROCESS | 16210 | (process:16271): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:57:54 INFO - PROCESS | 16210 | RSS: Main: 138772480 12:57:54 INFO - PROCESS | 16210 | 12:58:43 INFO - PROCESS | 16210 | 1458763123842 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] 13:00:50 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:42510/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42510/tests/dromaeo/cssquery-ext.html) 13:00:51 INFO - PROCESS | 16210 | RSS: Main: 144310272 13:00:51 INFO - PROCESS | 16210 | 13:03:53 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:42510/tests/dromaeo/cssquery-ext.html (next: http://localhost:42510/tests/dromaeo/cssquery-jquery.html) 13:03:54 INFO - PROCESS | 16210 | RSS: Main: 144302080 13:03:54 INFO - PROCESS | 16210 | 13:06:55 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:42510/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42510/tests/dromaeo/cssquery-mootools.html) 13:06:56 INFO - PROCESS | 16210 | RSS: Main: 142495744 13:06:56 INFO - PROCESS | 16210 | 13:09:58 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:42510/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42510/tests/dromaeo/cssquery-prototype.html) 13:09:58 INFO - PROCESS | 16210 | RSS: Main: 143503360 13:09:58 INFO - PROCESS | 16210 | 13:13:00 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:42510/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42510/tests/dromaeo/cssquery-yui.html) 13:13:01 INFO - PROCESS | 16210 | RSS: Main: 144273408 13:13:01 INFO - PROCESS | 16210 | 13:16:03 INFO - PROCESS | 16210 | Cycle 1(1): loaded http://localhost:42510/tests/dromaeo/cssquery-yui.html (next: http://localhost:42510/tests/dromaeo/cssquery-dojo.html) 13:16:03 INFO - PROCESS | 16210 | RSS: Main: 145764352 13:16:03 INFO - PROCESS | 16210 | 13:16:03 INFO - PROCESS | 16210 | __start_tp_report 13:16:03 INFO - PROCESS | 16210 | _x_x_mozilla_page_load 13:16:03 INFO - PROCESS | 16210 | _x_x_mozilla_page_load_details 13:16:03 INFO - PROCESS | 16210 | |i|pagename|runs| 13:16:03 INFO - PROCESS | 16210 | |0;dojo.html;3231.7899336543123;3265.9510107348387;3273.9508907366394;3274.132354925945;3306.553615261939;5237.266782650428;5258.4215736269025;5259.9474005259935;5266.631335806495;5301.681899086047;5229;5232.0320740663;5262.394824595172;5266.552343050836;5277.551408130304;4789.568938795499;4833.081714474256;4889.755512224375;4895.657303988723;4971.875703107415;4740.857774266778;4807.110684523357;4862.878428039309;4886.63350248731;4956.231784073474;4884.19410797218;4919.877003074916;4940.3330550375595;4951.356323677935;4957.702537847741;4849.199882019462;4871.2206047032305;4887.804487820483;4914.287428322873;4923.458419573862;4713.505081966413;4779.3070004849105;4782.378290822171;4809.398825146856;4841.007593443371;5070.138076527;5081;5123.923141152885;5127.102757017545;5133.897322053538;5631.662100273997;5648.068068768648;5649.378568357477;5656.2929633795775;5657.745401456944;5535.58483113768;5555.666660000373;5611.130274807411;5611.7474713637985;5709.628874123168;5291.391489978663;5374.167004114369;5375.16684913839;5384.6769193848495;5411.540019098381;5687.146927960839;5739.081746920556;5746.856328591819;5755.510781583613;5775.682337471395;5408.8377348679605;5473.644213126134;5521;5541.889162216733;5544.944550554443;5575.163725441135;5634.352049514358;5636.126400407861;5637.295338082739;5638.984982703153;5556.222128901957;5564.693941833238;5569.303837020372;5585.301837270341;5590.273264475592;5417.26866872975;5556.083246264402;5556.333240011225;5559.388467268597;5616.719164041863;4401.18578063053;4404.6256068233915;4406.140802543538;4409.3606427068535;4417.514073451917;3972.523297204354;3978.3236849735613;3984.362501999724;3989.7207195496035;3993.900152496211;5375.19372094189;5461.644993075437;5462.754176062087;5464.562834973192;5543.390227075019;5664.801731939445;5683.431656834367;5687.118496633028;5687.544996400278;5687.573431992534;5454.61817672767;5457.263269458573;5457.808976685797;5457.808976685797;5516.586256030814;4798.136335459581;4808.855734327975;4813.03739252151;4892.315075889378;4980.2778597103215;5838.649681019152;5845.240118784616;5854.619449735838;5864.67744274069;5874.353821079678;5643.068893632669;5646.265985422033;5650.717464126859;5662.8301150965535;5664.546836253007;5681.233033540584;5731.340895797037;5783.537317014713;5833.883322333445;5850.327212370632;5614.382417934105;5630.859228519156;5638.407967163389;5649.322081350264;5651.180578816131;5561.165825126263;5597.552195824405;5709.9714501427225;5722.998475266895;5731.971340143273;5453.481919217668;5454.154606036071;5519.558435325244;5575.944240557543;5599.272094627672;5567.498925096761;5572.3034620672415;5574.637648552831;5586.748596313095;5605.80379686709;5382.4886635769535;5474.945250547444;5492.423295553909;5496.422875598005;5528.226048353315;5477.424870388551;5532.446755324436;5563.109902415594;5570.303712035996;5583.804566840141;5452.563794896478;5479.452054794648;5488.313960754906;5506;5508.91736623943 13:16:03 INFO - PROCESS | 16210 | |1;ext.html;545.9454054594542;547.4771593128563;574.7499837570655;581.8545363659085;581.9621724587904;37487.25025499492;38516.42225366615;38524.807375963115;38552;38641.420378694274;38450.615493845056;38627.420588691195;38912.41631375532;38984;39054.41418378727;8443.577821108935;8595.5702214889;8600.827983440327;8637.52493612851;8639.136086391341;8436.873446898302;8746.781330466725;8753.562321883881;8765.298776097898;8777.473351598925;8700.912990870074;8812.030676625565;8812.1187881212;8835.469871807712;8840.160184782435;8685.435446695945;8740.737777866643;8745.344099192585;8803.207711306013;8805.339599530029;8555.95722021392;8605.354598405145;8658.437201581877;8697.173768491983;8705.129487051245;38847.22305553901;39117.804410978046;39189;39315;39435.802820986;3396.626371099177;3419.4186988212064;3610.422332426799;3759.887203383903;4078.775667338295;31685.52471712926;31761.523577146363;31798.364032719215;32257.354852902812;32482.35035299281;3771.528558930134;3885.2812229737588;3898.064464528521;3926.2147570486018;3970.682345412389;275080;277189;277369;277427;278106;44796;45249.77375113103;45709;45717.54282457133;45927.081458370645;41677.79161104175;41815;42089.368659470136;42177.15645687069;42224.15551688949;16414.09722465276;16803.663926721398;16820.15899205035;16824.242909069122;16857.157142142845;13532.255725935169;13535.864641353657;13584.049116561944;13615;13977.58067257984;15234.619134521725;15357.692846143238;15363.231838408035;15383.46157884491;15391.461298854487;5692.658440493501;5872.153739300765;5899.4985426239255;5912.970435147797;5921.407859214044;958.1137447860701;983.3706427886159;1050.2910535388583;1055.298226679265;1077.3159044006954;26405.33986650349;26803.865980669972;26958.191254262405;27113.45773084567;31316.9039083631;1086.6414083352474;1136.170595465315;1146.2091157101572;1160.988390116088;1198.4606926882936;14275.928620356832;14485.78271325931;14542.927285363505;14686.339114739862;14828.925855370655;441564;509363;511286;511488;750871;54453.45546544563;55161.172582411295;55304.72347638236;55516.72241638766;55596;1458.649924018228;1481.444458328127;1489.0618910086575;1495.5064828606535;1497.490853109926;29496.705032950253;30625;30928.845355773075;31246.843765781025;31533.211669708442;48196.7590162047;48650.270245945634;49115;49119.508804912926;49187.75406122946;286733;286852;286956;287691;287897;34083.659163409044;45157.77421112874;45362.865928352054;45634.08731825411;46264.30603541017;42174.57825421829;42599;42743.572564273956;42986.140277193655;43055.569444305154;36418.4537231947;36488;37131.25737485289;37625;37784.62215377921;39491.80254098711;39693.404598930465;39993.60006400015;40063.79968100141;40991.59008409997;35873.46189807103;36221.81889090538;36385.818070909474;36615.45076823796;36632.26735465329;31298;32786.836065819516;34801.12997175091;35029.29941401107;42400.36399453949;30503.237419064702;30534.694653053186;30927.536086959164;33225.667743323225;33437.33125337528 13:16:03 INFO - PROCESS | 16210 | |2;jquery.html;385.66061865558305;387.45755941681654;389.27507447864946;389.66099493440703;397.62225885408833;15791.921040394811;16051.83948160518;17437.389691360804;18051.187696553654;18153.27386904524;16906.647468202544;17169;17731.64536709265;17738.82261177391;18033.09834508276;5130.410002849673;5369.355677318727;5595.524380427648;5600;5601.467860553262;5356.38401583819;5537.750801213955;5549.445055494459;5580.497755202031;5592.161175823619;5385.865353366158;5542.91685624714;5567.916481252784;5574.247476590669;5600.747966341524;5536.335639723239;5561.165825126223;5583.553315734732;5597.468240517144;5613.298337707786;5348.358197016344;5392;5550.306211723535;5556.222128901957;5558.138488534284;13418.664533386645;13576.660583485393;19898.20407183711;20024.49938751543;20573.07421166051;2143.185589475989;2164.3723320237114;2194.8024677778917;2272.625016872214;2301.7583153768783;11049.889501104966;13365.131266467648;13658.795118073236;13684.52104176349;13957.092788968685;1914.636219118363;1947.4936516505811;1965.0764140853776;2005.0776642744356;2067.5348046689523;61144;61319.38680613226;61729.382706172815;62210.18396584058;62667.37332626661;11006.834897476545;11006.944965275123;11014.779704405866;11023.283486573348;11048.834267485994;14389.928050359891;14510.927445362706;14541.127532347882;14608.634784130481;14616.780748288784;8195.303399211014;8242.711505097293;8275.420720549624;8294.37792165578;8326.5004099753;7916.485428447248;7918.168592297841;7926.643301051467;7928;7967.760967170994;4601.792919318572;4763.404574428197;4857.295692124622;4886.096072226649;4920.040592084581;1833.1750712179573;1836.5133239691493;1947.74679291694;1961.9895753686862;1973.181129831104;909.7088931541844;981.2738573455591;1076.160594736107;1086.255914698434;1086.4024786367465;16225.51323460298;16770.664586708197;17182.22679979404;17498.300067997137;17944.641107177784;978.2125389061873;1032.6488993742164;1057.471264367816;1061.4374381577777;1063.3513556730388;8977.730668079968;9240;9312.627494900127;9327.580258888367;9474.336796424184;569778;571490;575513;597299;602433;69098.30901691019;69392;70086.29913700798;73160;73324.2667573328;1194.4266751959108;1211.255078126963;1217.3183017510223;1220.45079714129;1230.5508489401484;14888.776668349767;14989.700205995601;15029.323680434625;15142;15171;35748.28503429969;35793;36256.09359766027;36369.454458183674;37036.44445333376;45428.31857522206;46123.3081503771;46981.765091174326;47569.52430475789;47892;7380.298871607189;7468.066491688539;7529.284717951786;7557.584332861526;7592.734254301073;11063.668089957315;11108.722281942693;11500.769984600429;11622.6513204604;12102.092343074128;9994.350367226107;10169.491525423848;10550.31422957536;10586.89413105859;10738.785224295314;10294.124999374837;10474.476276186313;10477.214208934209;10520.789584208425;10774.353538787698;9812.607495700093;9917.404955702681;10234;10642.787144257227;10687.625933092304;7374.727993561247;7778.377729781717;7830.725924592612;7882.881756773539;8057.0734365548715;7446.888296675445;7582.54504729718;9876.358036727877;10598;10637.521311541153 13:16:03 INFO - PROCESS | 16210 | |3;mootools.html;1513.6594266290085;1528.88533359998;1714.1600615698312;1829.5426143464133;1851.9444416667504;7658.617069146541;7668.271514206149;7713.42149338799;7821.491603045798;7914.841703165933;7546.773596792092;7574.659140338684;7609.3532049775695;7623.428242881779;7643.9235607643905;2271.3980795089315;2280.749117597063;2281.315605318406;2287.039443433762;2292.266474728088;2202.812760915324;2254.7407048189502;2331.8717470539113;2333.603287441139;2346.061575369857;2261.604219261631;2277.6355783074628;2291.4844160063935;2313.2366319114653;2313.375388645065;2284.6116160252795;2298.9425264368356;2299.8620082795;2325.1164557468137;2326.1277021117166;2311.66480860276;2312.190733243368;2314.0628045641542;2315.4790172211287;2321.802646775026;7685.730999414994;7712.113106992655;7712.190220026872;7732.45872788905;7777.844443111106;4654.743989080599;4710.929336059928;4739.715617062987;4741;4744.715317080986;2872.5834753960767;2910.3306239565018;2980.478416277143;2993;3003.189138932498;925.1257561604286;939.9530023498797;954.0983770337034;977.7457860956132;984.547108330169;10582.68251952435;10662.520186591622;10714.303570267986;10738.624148154855;10742.3017503862;3994.500687414073;4025.1345960618023;4074;4082.408050832613;4084.4894388201474;8757.737267881974;8834.469931804113;8843.248323892412;8847.911520884709;8860.8670869937;4625.098105869391;4639.072185562901;4640.721556706609;4663.230566956482;4664.86005419838;4252.298370768788;4270.0605866709275;4273.166732487135;4314.050908800059;4323.870283891489;3321.9169520762175;3339.7328213743326;3349;3362.81504517249;3388.542546756206;971.5093877591771;979.1530326267728;987.8814542254831;996.5465713100667;1061.442742560162;1032.5353590884133;1041.245097304448;1050.1808589300358;1227.1532642476664;1408.542223777256;6935.6878940447805;6973.546719463218;6976.058232138698;6982.546134501241;7011.89482157768;1198.3049831097942;1221.91446598739;1223.2782658231686;1223.62067758995;1224.3510939202238;5727.6849773262875;5782.277215348082;5800.854978625568;5802.622829516153;5805.593608447368;8325.250727434439;8850.955745221232;8852.557372131369;8916.420432671985;8957.910420895707;8863.955680221557;8904.154105359981;8939.106089391138;8986.910130898737;9036.412633178954;7372.152202496674;7373;7447.292507211914;7524.247575242432;7553.206913274027;7032.437405007689;7035.12060992376;7090.361867431956;7105.46708996817;7114;8127.634256458592;8226.465279756796;8528.701495447629;8556.486610803371;8583.914160858312;8501.19238672325;8526.275266602408;8592.699255526026;8602.741917742478;8709.259712924219;6814.216365117876;6995.405390541861;6996.545224560387;7009.369156775914;7028.121484814398;7133.322334378433;7163.10461192351;7165.7850264492145;7175.390091842252;7208.45936554771;6591.604503729792;6632.635205063768;6731.798046058626;6792.456603471809;6851.623160726208;6376;6452.806415807533;6466.579672321284;6563.835904102436;6586.242582103119;6674.632895190617;6755.392014718699;6766.5263431559315;6771.796846094428;6774.153230846145;6225.564210505402;6253.530985176039;6266.749330026931;6281.3404592518955;6290.905636415366;6383.904241436475;6423.486121110206;6452.870942581216;6484.805455836144;6608.603483790988 13:16:03 INFO - PROCESS | 16210 | |4;prototype.html;331.1720698254364;334.91961929137017;335.8387973772589;352.2215902854691;355.1565033046514;6257.092721555383;6287.968560157198;6288.402601752838;6373.107764912905;6387.393197646228;6054.243219597551;6157.692115394235;6189.597676151047;6229.4704950079185;6231.937680623192;4829.22732362822;4831.396075490564;4833.782479788418;4841.273808928671;4843.104025755229;4840.9515904840855;4841.225403935371;4844.32179494871;4846.200376937819;4846.321514987904;4716.4340279166545;4793.90412191756;4802.303665968432;4818.036392721452;4823.155947709137;4775.164346239429;4791.28130780384;4799.256115302133;4804.855854324376;4805.495422980589;4241.49102107746;4245.681573881971;4249.277622804131;4250.256205164084;4251.851185208503;5956.434138756811;5957.1957785698805;5961.880762384728;5987.880242395171;5992.910106348409;5521.889562208774;5616.887662246773;5637.633553818989;5658.603897727161;5662.094064949588;6632.436242919358;6665.166854143232;6669.199696036459;6690;6699.39705426509;4717;4722.8110875564935;4727.574518293336;4730.314104454869;4741.122892264908;6832.863342733118;6939.028536005014;6986.37122658958;7026;7026.191987921404;4601.884952876205;4660.883477913079;4671.953280467152;4683.7892294846815;4695.3191787191345;4725.196716558194;4735.360726301974;4753.952460475421;4754.762261886892;4767.499412561631;5533.501984821305;5538.141588053778;5544.750486228129;5544.91682624761;5553.083741182741;6593.835154121185;6739.393454589111;6742.662866856637;6750.493712971547;6750.628715420699;1648.8021437427585;1676.430013795291;1699.6345785656142;1701.9404320848712;1703.8892471989282;1130.4856290387854;1132.049078773834;1135.4720055174384;1137.778133264022;1142.3260276436943;6537.444317233088;6540.836479087966;6569.981652843817;6573.57271777333;6591.538592298589;6852.143482064742;6886.345797149263;6891.689873955584;6903.5167538271835;6912.516123871382;6479.611223326616;6490.610563366213;6495.837604059841;6541.771038013647;6560.540762146699;3747.887563373103;3763.5295588051495;3771.849126034928;3777.99883030997;3791.2227993261317;7231.819204519824;7284;7300.780976570712;7318.634068296564;7344.48588598793;7066.787996360117;7211;7220.277972202738;7221.24176961422;7239.9276007240305;7291.781246562506;7317.304856038668;7325.304096110861;7328.047353843966;7337.816554586178;6995.195552511526;7018.227994920657;7026.262242464468;7027.297270272932;7030.929690703232;6723.193216813818;6868.9313106870295;6923.307669233238;6930.27232140618;6935.445164386736;7327.926720732938;7350.96324518374;7351.3751331137455;7360.116785985716;7385.076865391826;4709.576138147583;4748;4756.048790242035;4786.1863483208635;4787.281907713732;6911.3779759821855;6945.131858517685;7064.187618423947;7066.540674856118;7086.468514861509;6837.247902730795;6845.657717114024;6868.072810170763;6891.586504809728;6897.55165914214;6846.897296540656;6855.108835851307;6868.828279292858;6875.7937261882225;6889.483288753263;6508.186476690414;6647.102641143384;6668.199816022108;6680.365365290289;6738.9891516272955;6788.76239331621;6814.2163651180745;6815.216250131299;6863.828404289933;6882.070920425678;6687.264400915993;6703.899441508479;6726.159230096238;6742.93257067423;6744.0558321834005 13:16:03 INFO - PROCESS | 16210 | |5;yui.html;786.7954331873711;799.272661877691;802.3541049455187;810.1048341582551;840.7393707950536;12134.878651213485;12154.69613259669;12226.327551984648;12243.877561224384;12267.447964841582;13355.53255636053;13477;13518.053736238468;13519;13519.12125711828;883.2624758326805;912.9817403651923;917.3349321741717;919.296737995434;921.1341339141186;879.5821984557316;896.5158814240302;896.5920506169678;898.9955050224739;899.9775005624879;930.6417029443679;939.9389039712397;940.8541676040225;941.6421759731293;943.4999450291357;929.6142101028065;930.878985731854;932.5523748600676;934.0985948559672;936.6815282803811;684.4968947823346;690.9930900690979;691.0705101638289;691.4261163234554;692.7506097804786;14710.779338309934;14794.112353258839;14818.110913345234;14835.48075817352;14874.405023799036;13131.146475479063;13136.474541018348;13147.211167329991;13329.73340533184;13364.465421383133;9585.568649410723;9652.179564737005;9681.41911485306;9759.072888075621;9788.902110978941;3632.0738211755834;3649.4525821126776;3665.193657395369;3685.9262814743556;3695.6489133532273;48936.26595601069;49216;50083.999999999636;50244.74877625588;50649.24026139611;10286.588536458608;10560.841587376195;10570.312929659547;10636.574537018432;10829.24195306321;18524.25902963893;18562.907185463988;18641.627167456576;18737.437876863714;18867.811321886606;7589.506682065648;7711.305982461606;7839.25527074927;7897.17079706634;7992.3606111510935;3916.1971795781797;3943.881683549498;3944.447777311179;3950.486436763202;3976.2445135424177;3012.638483382008;3017.09487153853;3046.8933587324336;3047.1924939890505;3058.525928481089;536.7074944155445;559.5216090242784;563.7096895099028;581.3140494216865;583.375787906944;516.7648719832467;528.6854321678595;596.4602035158189;601.5728832528954;644.7388807532957;7844.803879902934;8170.836583268301;9081.318901082444;9253.213476854542;9330.253579713606;527.6359312074657;534.6097348935222;578.945000224978;581.9621724587888;710.7512370670224;3746.4754934309217;3989.880303590839;4056.675465962775;4180.1012782251355;4292.914141717149;50949.490505095215;51296.23055654168;51563.48436515662;52016.479835201164;52019.73990130025;47087.76456117698;47112.5288747115;47182.528174717816;47646.28530572044;47873.28190077082;45276.77361613237;45548.3167752484;45575.544244557794;45989.54010459853;46369.76815115903;8016.158303378062;8422.831543368975;8468.449550779425;8575.61409736551;8602.225799678059;34149.82925085359;34609.65390346065;35057.298854023284;35701.82149089238;36153.819230903675;40772.59227407688;41451.37822932598;44739;44745;44786.104277913604;10915.727106822393;11089.390083545482;11112.611058612909;11118.555257789598;11361.375124367909;12441.875581244434;12750.171238869443;12950.222986620833;13046.869531304565;13414.195148291134;10914.290571112851;11399.943000284946;11472.713182170179;11669.299842009506;12100.213486123374;11509.309441433541;11534.538618455168;11594.768104637691;11849.229800063313;11856.644300670994;11714.472848721658;11871.584494542994;11901.345426001653;12037.337946413032;12049.216800907912;9420.858687119835;9460.479673617741;9829.705108846745;10014.799704005733;10027.749306267402;10098.646547370807;10326.741831454274;10411.94794026025;10476.738081548023;10518.684439466828 13:16:03 INFO - PROCESS | 16210 | __end_tp_report 13:16:03 INFO - PROCESS | 16210 | __start_cc_report 13:16:03 INFO - PROCESS | 16210 | _x_x_mozilla_cycle_collect,285 13:16:03 INFO - PROCESS | 16210 | __end_cc_report 13:16:03 INFO - PROCESS | 16210 | __startTimestamp1458764163930__endTimestamp 13:16:03 INFO - PROCESS | 16210 | 13:16:03 INFO - PROCESS | 16210 | ------- Summary: start ------- 13:16:03 INFO - PROCESS | 16210 | Number of tests: 6 13:16:03 INFO - PROCESS | 16210 | 13:16:03 INFO - PROCESS | 16210 | [#0] dojo.html Cycles:165 Average:5269.23 Median:5479.45 stddev:549.65 (10.0%) stddev-sans-first:527.59 13:16:03 INFO - PROCESS | 16210 | Values: 3231.8 3266.0 3274.0 3274.1 3306.6 5237.3 5258.4 5259.9 5266.6 5301.7 5229.0 5232.0 5262.4 5266.6 5277.6 4789.6 4833.1 4889.8 4895.7 4971.9 4740.9 4807.1 4862.9 4886.6 4956.2 4884.2 4919.9 4940.3 4951.4 4957.7 4849.2 4871.2 4887.8 4914.3 4923.5 4713.5 4779.3 4782.4 4809.4 4841.0 5070.1 5081.0 5123.9 5127.1 5133.9 5631.7 5648.1 5649.4 5656.3 5657.7 5535.6 5555.7 5611.1 5611.7 5709.6 5291.4 5374.2 5375.2 5384.7 5411.5 5687.1 5739.1 5746.9 5755.5 5775.7 5408.8 5473.6 5521.0 5541.9 5544.9 5575.2 5634.4 5636.1 5637.3 5639.0 5556.2 5564.7 5569.3 5585.3 5590.3 5417.3 5556.1 5556.3 5559.4 5616.7 4401.2 4404.6 4406.1 4409.4 4417.5 3972.5 3978.3 3984.4 3989.7 3993.9 5375.2 5461.6 5462.8 5464.6 5543.4 5664.8 5683.4 5687.1 5687.5 5687.6 5454.6 5457.3 5457.8 5457.8 5516.6 4798.1 4808.9 4813.0 4892.3 4980.3 5838.6 5845.2 5854.6 5864.7 5874.4 5643.1 5646.3 5650.7 5662.8 5664.5 5681.2 5731.3 5783.5 5833.9 5850.3 5614.4 5630.9 5638.4 5649.3 5651.2 5561.2 5597.6 5710.0 5723.0 5732.0 5453.5 5454.2 5519.6 5575.9 5599.3 5567.5 5572.3 5574.6 5586.7 5605.8 5382.5 5474.9 5492.4 5496.4 5528.2 5477.4 5532.4 5563.1 5570.3 5583.8 5452.6 5479.5 5488.3 5506.0 5508.9 13:16:03 INFO - PROCESS | 16210 | 13:16:03 INFO - PROCESS | 16210 | [#1] ext.html Cycles:180 Average:52650.43 Median:21366.25 stddev:105157.13 (492.2%) stddev-sans-first:105379.36 13:16:03 INFO - PROCESS | 16210 | Values: 545.9 547.5 574.7 581.9 582.0 37487.3 38516.4 38524.8 38552.0 38641.4 38450.6 38627.4 38912.4 38984.0 39054.4 8443.6 8595.6 8600.8 8637.5 8639.1 8436.9 8746.8 8753.6 8765.3 8777.5 8700.9 8812.0 8812.1 8835.5 8840.2 8685.4 8740.7 8745.3 8803.2 8805.3 8556.0 8605.4 8658.4 8697.2 8705.1 38847.2 39117.8 39189.0 39315.0 39435.8 3396.6 3419.4 3610.4 3759.9 4078.8 31685.5 31761.5 31798.4 32257.4 32482.4 3771.5 3885.3 3898.1 3926.2 3970.7 275080.0 277189.0 277369.0 277427.0 278106.0 44796.0 45249.8 45709.0 45717.5 45927.1 41677.8 41815.0 42089.4 42177.2 42224.2 16414.1 16803.7 16820.2 16824.2 16857.2 13532.3 13535.9 13584.0 13615.0 13977.6 15234.6 15357.7 15363.2 15383.5 15391.5 5692.7 5872.2 5899.5 5913.0 5921.4 958.1 983.4 1050.3 1055.3 1077.3 26405.3 26803.9 26958.2 27113.5 31316.9 1086.6 1136.2 1146.2 1161.0 1198.5 14275.9 14485.8 14542.9 14686.3 14828.9 441564.0 509363.0 511286.0 511488.0 750871.0 54453.5 55161.2 55304.7 55516.7 55596.0 1458.6 1481.4 1489.1 1495.5 1497.5 29496.7 30625.0 30928.8 31246.8 31533.2 48196.8 48650.3 49115.0 49119.5 49187.8 286733.0 286852.0 286956.0 287691.0 287897.0 34083.7 45157.8 45362.9 45634.1 46264.3 42174.6 42599.0 42743.6 42986.1 43055.6 36418.5 36488.0 37131.3 37625.0 37784.6 39491.8 39693.4 39993.6 40063.8 40991.6 35873.5 36221.8 36385.8 36615.5 36632.3 31298.0 32786.8 34801.1 35029.3 42400.4 30503.2 30534.7 30927.5 33225.7 33437.3 13:16:03 INFO - PROCESS | 16210 | 13:16:03 INFO - PROCESS | 16210 | [#2] jquery.html Cycles:180 Average:29359.50 Median:18711.05 stddev:95248.03 (509.0%) stddev-sans-first:95490.38 13:16:03 INFO - PROCESS | 16210 | Values: 385.7 387.5 389.3 389.7 397.6 15791.9 16051.8 17437.4 18051.2 18153.3 16906.6 17169.0 17731.6 17738.8 18033.1 5130.4 5369.4 5595.5 5600.0 5601.5 5356.4 5537.8 5549.4 5580.5 5592.2 5385.9 5542.9 5567.9 5574.2 5600.7 5536.3 5561.2 5583.6 5597.5 5613.3 5348.4 5392.0 5550.3 5556.2 5558.1 13418.7 13576.7 19898.2 20024.5 20573.1 2143.2 2164.4 2194.8 2272.6 2301.8 11049.9 13365.1 13658.8 13684.5 13957.1 1914.6 1947.5 1965.1 2005.1 2067.5 61144.0 61319.4 61729.4 62210.2 62667.4 11006.8 11006.9 11014.8 11023.3 11048.8 14389.9 14510.9 14541.1 14608.6 14616.8 8195.3 8242.7 8275.4 8294.4 8326.5 7916.5 7918.2 7926.6 7928.0 7967.8 4601.8 4763.4 4857.3 4886.1 4920.0 1833.2 1836.5 1947.7 1962.0 1973.2 909.7 981.3 1076.2 1086.3 1086.4 16225.5 16770.7 17182.2 17498.3 17944.6 978.2 1032.6 1057.5 1061.4 1063.4 8977.7 9240.0 9312.6 9327.6 9474.3 569778.0 571490.0 575513.0 597299.0 602433.0 69098.3 69392.0 70086.3 73160.0 73324.3 1194.4 1211.3 1217.3 1220.5 1230.6 14888.8 14989.7 15029.3 15142.0 15171.0 35748.3 35793.0 36256.1 36369.5 37036.4 45428.3 46123.3 46981.8 47569.5 47892.0 7380.3 7468.1 7529.3 7557.6 7592.7 11063.7 11108.7 11500.8 11622.7 12102.1 9994.4 10169.5 10550.3 10586.9 10738.8 10294.1 10474.5 10477.2 10520.8 10774.4 9812.6 9917.4 10234.0 10642.8 10687.6 7374.7 7778.4 7830.7 7882.9 8057.1 7446.9 7582.5 9876.4 10598.0 10637.5 13:16:03 INFO - PROCESS | 16210 | 13:16:03 INFO - PROCESS | 16210 | [#3] mootools.html Cycles:180 Average:5359.56 Median:6459.73 stddev:2754.09 (42.6%) stddev-sans-first:2746.65 13:16:03 INFO - PROCESS | 16210 | Values: 1513.7 1528.9 1714.2 1829.5 1851.9 7658.6 7668.3 7713.4 7821.5 7914.8 7546.8 7574.7 7609.4 7623.4 7643.9 2271.4 2280.7 2281.3 2287.0 2292.3 2202.8 2254.7 2331.9 2333.6 2346.1 2261.6 2277.6 2291.5 2313.2 2313.4 2284.6 2298.9 2299.9 2325.1 2326.1 2311.7 2312.2 2314.1 2315.5 2321.8 7685.7 7712.1 7712.2 7732.5 7777.8 4654.7 4710.9 4739.7 4741.0 4744.7 2872.6 2910.3 2980.5 2993.0 3003.2 925.1 940.0 954.1 977.7 984.5 10582.7 10662.5 10714.3 10738.6 10742.3 3994.5 4025.1 4074.0 4082.4 4084.5 8757.7 8834.5 8843.2 8847.9 8860.9 4625.1 4639.1 4640.7 4663.2 4664.9 4252.3 4270.1 4273.2 4314.1 4323.9 3321.9 3339.7 3349.0 3362.8 3388.5 971.5 979.2 987.9 996.5 1061.4 1032.5 1041.2 1050.2 1227.2 1408.5 6935.7 6973.5 6976.1 6982.5 7011.9 1198.3 1221.9 1223.3 1223.6 1224.4 5727.7 5782.3 5800.9 5802.6 5805.6 8325.3 8851.0 8852.6 8916.4 8957.9 8864.0 8904.2 8939.1 8986.9 9036.4 7372.2 7373.0 7447.3 7524.2 7553.2 7032.4 7035.1 7090.4 7105.5 7114.0 8127.6 8226.5 8528.7 8556.5 8583.9 8501.2 8526.3 8592.7 8602.7 8709.3 6814.2 6995.4 6996.5 7009.4 7028.1 7133.3 7163.1 7165.8 7175.4 7208.5 6591.6 6632.6 6731.8 6792.5 6851.6 6376.0 6452.8 6466.6 6563.8 6586.2 6674.6 6755.4 6766.5 6771.8 6774.2 6225.6 6253.5 6266.7 6281.3 6290.9 6383.9 6423.5 6452.9 6484.8 6608.6 13:16:03 INFO - PROCESS | 16210 | 13:16:03 INFO - PROCESS | 16210 | [#4] prototype.html Cycles:180 Average:5647.03 Median:6485.11 stddev:1724.13 (26.6%) stddev-sans-first:1682.17 13:16:03 INFO - PROCESS | 16210 | Values: 331.2 334.9 335.8 352.2 355.2 6257.1 6288.0 6288.4 6373.1 6387.4 6054.2 6157.7 6189.6 6229.5 6231.9 4829.2 4831.4 4833.8 4841.3 4843.1 4841.0 4841.2 4844.3 4846.2 4846.3 4716.4 4793.9 4802.3 4818.0 4823.2 4775.2 4791.3 4799.3 4804.9 4805.5 4241.5 4245.7 4249.3 4250.3 4251.9 5956.4 5957.2 5961.9 5987.9 5992.9 5521.9 5616.9 5637.6 5658.6 5662.1 6632.4 6665.2 6669.2 6690.0 6699.4 4717.0 4722.8 4727.6 4730.3 4741.1 6832.9 6939.0 6986.4 7026.0 7026.2 4601.9 4660.9 4672.0 4683.8 4695.3 4725.2 4735.4 4754.0 4754.8 4767.5 5533.5 5538.1 5544.8 5544.9 5553.1 6593.8 6739.4 6742.7 6750.5 6750.6 1648.8 1676.4 1699.6 1701.9 1703.9 1130.5 1132.0 1135.5 1137.8 1142.3 6537.4 6540.8 6570.0 6573.6 6591.5 6852.1 6886.3 6891.7 6903.5 6912.5 6479.6 6490.6 6495.8 6541.8 6560.5 3747.9 3763.5 3771.8 3778.0 3791.2 7231.8 7284.0 7300.8 7318.6 7344.5 7066.8 7211.0 7220.3 7221.2 7239.9 7291.8 7317.3 7325.3 7328.0 7337.8 6995.2 7018.2 7026.3 7027.3 7030.9 6723.2 6868.9 6923.3 6930.3 6935.4 7327.9 7351.0 7351.4 7360.1 7385.1 4709.6 4748.0 4756.0 4786.2 4787.3 6911.4 6945.1 7064.2 7066.5 7086.5 6837.2 6845.7 6868.1 6891.6 6897.6 6846.9 6855.1 6868.8 6875.8 6889.5 6508.2 6647.1 6668.2 6680.4 6739.0 6788.8 6814.2 6815.2 6863.8 6882.1 6687.3 6703.9 6726.2 6742.9 6744.1 13:16:03 INFO - PROCESS | 16210 | 13:16:03 INFO - PROCESS | 16210 | [#5] yui.html Cycles:180 Average:13650.75 Median:44765.55 stddev:15260.82 (34.1%) stddev-sans-first:15273.06 13:16:03 INFO - PROCESS | 16210 | Values: 786.8 799.3 802.4 810.1 840.7 12134.9 12154.7 12226.3 12243.9 12267.4 13355.5 13477.0 13518.1 13519.0 13519.1 883.3 913.0 917.3 919.3 921.1 879.6 896.5 896.6 899.0 900.0 930.6 939.9 940.9 941.6 943.5 929.6 930.9 932.6 934.1 936.7 684.5 691.0 691.1 691.4 692.8 14710.8 14794.1 14818.1 14835.5 14874.4 13131.1 13136.5 13147.2 13329.7 13364.5 9585.6 9652.2 9681.4 9759.1 9788.9 3632.1 3649.5 3665.2 3685.9 3695.6 48936.3 49216.0 50084.0 50244.7 50649.2 10286.6 10560.8 10570.3 10636.6 10829.2 18524.3 18562.9 18641.6 18737.4 18867.8 7589.5 7711.3 7839.3 7897.2 7992.4 3916.2 3943.9 3944.4 3950.5 3976.2 3012.6 3017.1 3046.9 3047.2 3058.5 536.7 559.5 563.7 581.3 583.4 516.8 528.7 596.5 601.6 644.7 7844.8 8170.8 9081.3 9253.2 9330.3 527.6 534.6 578.9 582.0 710.8 3746.5 3989.9 4056.7 4180.1 4292.9 50949.5 51296.2 51563.5 52016.5 52019.7 47087.8 47112.5 47182.5 47646.3 47873.3 45276.8 45548.3 45575.5 45989.5 46369.8 8016.2 8422.8 8468.4 8575.6 8602.2 34149.8 34609.7 35057.3 35701.8 36153.8 40772.6 41451.4 44739.0 44745.0 44786.1 10915.7 11089.4 11112.6 11118.6 11361.4 12441.9 12750.2 12950.2 13046.9 13414.2 10914.3 11399.9 11472.7 11669.3 12100.2 11509.3 11534.5 11594.8 11849.2 11856.6 11714.5 11871.6 11901.3 12037.3 12049.2 9420.9 9460.5 9829.7 10014.8 10027.7 10098.6 10326.7 10411.9 10476.7 10518.7 13:16:03 INFO - PROCESS | 16210 | -------- Summary: end -------- 13:16:03 INFO - PROCESS | 16210 | 13:16:04 INFO - TEST-INFO | 16210: exit 0 13:16:04 INFO - TEST-OK | dromaeo_css | took 1107849ms 13:16:04 INFO - TEST-START | kraken 13:16:04 INFO - operating with platform_type : linux_ 13:16:04 INFO - Initialising browser for kraken test... 13:16:04 INFO - TEST-INFO | started process 16452 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8qYODs/profile http://localhost:42510/getInfo.html) 13:16:08 INFO - PROCESS | 16452 | 13:16:08 INFO - PROCESS | 16452 | (process:16530): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:16:09 INFO - PROCESS | 16452 | __metrics Screen width/height:1600/1200 13:16:09 INFO - PROCESS | 16452 | colorDepth:24 13:16:09 INFO - PROCESS | 16452 | Browser inner width/height: 1024/697 13:16:09 INFO - PROCESS | 16452 | __metrics 13:16:10 INFO - TEST-INFO | 16452: exit 0 13:16:10 INFO - Browser initialized. 13:16:10 INFO - Running cycle 1/1 for kraken test... 13:16:10 INFO - TEST-INFO | started process 16578 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8qYODs/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:16:11 INFO - PROCESS | 16578 | 13:16:11 INFO - PROCESS | 16578 | (process:16639): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:16:21 INFO - PROCESS | 16578 | RSS: Main: 138469376 13:16:21 INFO - PROCESS | 16578 | 13:16:24 INFO - PROCESS | 16578 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42510/tests/kraken/driver.html?testName=audio-beat-detection) 13:16:24 INFO - PROCESS | 16578 | RSS: Main: 142397440 13:16:24 INFO - PROCESS | 16578 | 13:16:27 INFO - PROCESS | 16578 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42510/tests/kraken/driver.html?testName=audio-dft) 13:16:28 INFO - PROCESS | 16578 | RSS: Main: 143507456 13:16:28 INFO - PROCESS | 16578 | 13:16:30 INFO - PROCESS | 16578 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42510/tests/kraken/driver.html?testName=audio-fft) 13:16:31 INFO - PROCESS | 16578 | RSS: Main: 143073280 13:16:31 INFO - PROCESS | 16578 | 13:16:33 INFO - PROCESS | 16578 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42510/tests/kraken/driver.html?testName=audio-oscillator) 13:16:34 INFO - PROCESS | 16578 | RSS: Main: 143122432 13:16:34 INFO - PROCESS | 16578 | 13:16:36 INFO - PROCESS | 16578 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42510/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:16:36 INFO - PROCESS | 16578 | RSS: Main: 144035840 13:16:36 INFO - PROCESS | 16578 | 13:16:39 INFO - PROCESS | 16578 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42510/tests/kraken/driver.html?testName=imaging-darkroom) 13:16:40 INFO - PROCESS | 16578 | RSS: Main: 143343616 13:16:40 INFO - PROCESS | 16578 | 13:16:43 INFO - PROCESS | 16578 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42510/tests/kraken/driver.html?testName=imaging-desaturate) 13:16:44 INFO - PROCESS | 16578 | RSS: Main: 143933440 13:16:44 INFO - PROCESS | 16578 | 13:16:47 INFO - PROCESS | 16578 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42510/tests/kraken/driver.html?testName=json-parse-financial) 13:16:47 INFO - PROCESS | 16578 | RSS: Main: 144179200 13:16:47 INFO - PROCESS | 16578 | 13:16:49 INFO - PROCESS | 16578 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42510/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:16:49 INFO - PROCESS | 16578 | RSS: Main: 144822272 13:16:49 INFO - PROCESS | 16578 | 13:16:51 INFO - PROCESS | 16578 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42510/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:16:52 INFO - PROCESS | 16578 | RSS: Main: 144629760 13:16:52 INFO - PROCESS | 16578 | 13:16:54 INFO - PROCESS | 16578 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42510/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:16:54 INFO - PROCESS | 16578 | RSS: Main: 144101376 13:16:54 INFO - PROCESS | 16578 | 13:16:57 INFO - PROCESS | 16578 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:16:57 INFO - PROCESS | 16578 | RSS: Main: 144838656 13:16:57 INFO - PROCESS | 16578 | 13:17:00 INFO - PROCESS | 16578 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:17:00 INFO - PROCESS | 16578 | RSS: Main: 144519168 13:17:00 INFO - PROCESS | 16578 | 13:17:02 INFO - PROCESS | 16578 | Cycle 1(1): loaded http://localhost:42510/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42510/tests/kraken/driver.html?testName=ai-astar) 13:17:02 INFO - PROCESS | 16578 | RSS: Main: 144822272 13:17:02 INFO - PROCESS | 16578 | 13:17:02 INFO - PROCESS | 16578 | __start_tp_report 13:17:02 INFO - PROCESS | 16578 | _x_x_mozilla_page_load 13:17:02 INFO - PROCESS | 16578 | _x_x_mozilla_page_load_details 13:17:02 INFO - PROCESS | 16578 | |i|pagename|runs| 13:17:02 INFO - PROCESS | 16578 | |0;ai-astar;111;107;113;111;111;121;109;112;112;112 13:17:02 INFO - PROCESS | 16578 | |1;audio-beat-detection;157;126;151;162;125;163;150;129;169;128 13:17:02 INFO - PROCESS | 16578 | |2;audio-dft;161;162;163;163;165;163;162;162;166;162 13:17:02 INFO - PROCESS | 16578 | |3;audio-fft;73;73;76;155;77;77;76;76;153;76 13:17:02 INFO - PROCESS | 16578 | |4;audio-oscillator;104;97;137;96;95;96;142;95;96;140 13:17:02 INFO - PROCESS | 16578 | |5;imaging-gaussian-blur;109;110;110;110;110;110;109;110;110;111 13:17:02 INFO - PROCESS | 16578 | |6;imaging-darkroom;148;147;147;147;146;147;147;147;146;147 13:17:02 INFO - PROCESS | 16578 | |7;imaging-desaturate;97;96;97;97;97;96;97;96;97;97 13:17:02 INFO - PROCESS | 16578 | |8;json-parse-financial;57;60;57;61;56;60;58;57;55;54 13:17:02 INFO - PROCESS | 16578 | |9;json-stringify-tinderbox;63;64;63;65;65;64;64;64;69;65 13:17:02 INFO - PROCESS | 16578 | |10;stanford-crypto-aes;86;79;81;83;82;86;79;83;80;80 13:17:02 INFO - PROCESS | 16578 | |11;stanford-crypto-ccm;116;123;110;119;111;110;127;116;108;123 13:17:02 INFO - PROCESS | 16578 | |12;stanford-crypto-pbkdf2;147;138;138;136;141;137;135;144;140;139 13:17:02 INFO - PROCESS | 16578 | |13;stanford-crypto-sha256-iterative;65;68;67;66;64;69;66;65;69;64 13:17:02 INFO - PROCESS | 16578 | __end_tp_report 13:17:02 INFO - PROCESS | 16578 | __start_cc_report 13:17:02 INFO - PROCESS | 16578 | _x_x_mozilla_cycle_collect,700 13:17:02 INFO - PROCESS | 16578 | __end_cc_report 13:17:02 INFO - PROCESS | 16578 | __startTimestamp1458764222723__endTimestamp 13:17:02 INFO - PROCESS | 16578 | 13:17:02 INFO - PROCESS | 16578 | ------- Summary: start ------- 13:17:02 INFO - PROCESS | 16578 | Number of tests: 14 13:17:02 INFO - PROCESS | 16578 | 13:17:02 INFO - PROCESS | 16578 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:3.63 (3.2%) stddev-sans-first:3.84 13:17:02 INFO - PROCESS | 16578 | Values: 111.0 107.0 113.0 111.0 111.0 121.0 109.0 112.0 112.0 112.0 13:17:02 INFO - PROCESS | 16578 | 13:17:02 INFO - PROCESS | 16578 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:154.00 stddev:17.29 (11.2%) stddev-sans-first:17.87 13:17:02 INFO - PROCESS | 16578 | Values: 157.0 126.0 151.0 162.0 125.0 163.0 150.0 129.0 169.0 128.0 13:17:02 INFO - PROCESS | 16578 | 13:17:02 INFO - PROCESS | 16578 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.52 (0.9%) stddev-sans-first:1.45 13:17:02 INFO - PROCESS | 16578 | Values: 161.0 162.0 163.0 163.0 165.0 163.0 162.0 162.0 166.0 162.0 13:17:02 INFO - PROCESS | 16578 | 13:17:02 INFO - PROCESS | 16578 | [#3] audio-fft Cycles:10 Average:91.20 Median:76.00 stddev:33.13 (43.6%) stddev-sans-first:34.48 13:17:02 INFO - PROCESS | 16578 | Values: 73.0 73.0 76.0 155.0 77.0 77.0 76.0 76.0 153.0 76.0 13:17:02 INFO - PROCESS | 16578 | 13:17:02 INFO - PROCESS | 16578 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:95.50 stddev:20.80 (21.8%) stddev-sans-first:21.96 13:17:02 INFO - PROCESS | 16578 | Values: 104.0 97.0 137.0 96.0 95.0 96.0 142.0 95.0 96.0 140.0 13:17:02 INFO - PROCESS | 16578 | 13:17:02 INFO - PROCESS | 16578 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 13:17:02 INFO - PROCESS | 16578 | Values: 109.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 110.0 111.0 13:17:02 INFO - PROCESS | 16578 | 13:17:02 INFO - PROCESS | 16578 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 13:17:02 INFO - PROCESS | 16578 | Values: 148.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 146.0 147.0 13:17:02 INFO - PROCESS | 16578 | 13:17:02 INFO - PROCESS | 16578 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 13:17:02 INFO - PROCESS | 16578 | Values: 97.0 96.0 97.0 97.0 97.0 96.0 97.0 96.0 97.0 97.0 13:17:02 INFO - PROCESS | 16578 | 13:17:02 INFO - PROCESS | 16578 | [#8] json-parse-financial Cycles:10 Average:57.50 Median:57.50 stddev:2.27 (4.0%) stddev-sans-first:2.40 13:17:02 INFO - PROCESS | 16578 | Values: 57.0 60.0 57.0 61.0 56.0 60.0 58.0 57.0 55.0 54.0 13:17:02 INFO - PROCESS | 16578 | 13:17:02 INFO - PROCESS | 16578 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:64.50 stddev:1.71 (2.7%) stddev-sans-first:1.72 13:17:02 INFO - PROCESS | 16578 | Values: 63.0 64.0 63.0 65.0 65.0 64.0 64.0 64.0 69.0 65.0 13:17:02 INFO - PROCESS | 16578 | 13:17:02 INFO - PROCESS | 16578 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.50 stddev:2.60 (3.2%) stddev-sans-first:2.30 13:17:02 INFO - PROCESS | 16578 | Values: 86.0 79.0 81.0 83.0 82.0 86.0 79.0 83.0 80.0 80.0 13:17:02 INFO - PROCESS | 16578 | 13:17:02 INFO - PROCESS | 16578 | [#11] stanford-crypto-ccm Cycles:10 Average:116.30 Median:117.50 stddev:6.57 (5.6%) stddev-sans-first:6.96 13:17:02 INFO - PROCESS | 16578 | Values: 116.0 123.0 110.0 119.0 111.0 110.0 127.0 116.0 108.0 123.0 13:17:02 INFO - PROCESS | 16578 | 13:17:02 INFO - PROCESS | 16578 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.50 Median:139.50 stddev:3.69 (2.6%) stddev-sans-first:2.74 13:17:02 INFO - PROCESS | 16578 | Values: 147.0 138.0 138.0 136.0 141.0 137.0 135.0 144.0 140.0 139.0 13:17:02 INFO - PROCESS | 16578 | 13:17:02 INFO - PROCESS | 16578 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.89 (2.8%) stddev-sans-first:1.94 13:17:02 INFO - PROCESS | 16578 | Values: 65.0 68.0 67.0 66.0 64.0 69.0 66.0 65.0 69.0 64.0 13:17:02 INFO - PROCESS | 16578 | -------- Summary: end -------- 13:17:02 INFO - PROCESS | 16578 | 13:17:03 INFO - TEST-INFO | 16578: exit 0 13:17:03 INFO - TEST-OK | kraken | took 59023ms 13:17:03 INFO - TEST-START | v8_7 13:17:03 INFO - operating with platform_type : linux_ 13:17:03 INFO - Initialising browser for v8_7 test... 13:17:03 INFO - TEST-INFO | started process 16869 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyY0PNl/profile http://localhost:42510/getInfo.html) 13:17:07 INFO - PROCESS | 16869 | 13:17:07 INFO - PROCESS | 16869 | (process:16945): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:17:08 INFO - PROCESS | 16869 | __metrics Screen width/height:1600/1200 13:17:08 INFO - PROCESS | 16869 | colorDepth:24 13:17:08 INFO - PROCESS | 16869 | Browser inner width/height: 1024/697 13:17:08 INFO - PROCESS | 16869 | __metrics 13:17:09 INFO - TEST-INFO | 16869: exit 0 13:17:09 INFO - Browser initialized. 13:17:09 INFO - Running cycle 1/1 for v8_7 test... 13:17:09 INFO - TEST-INFO | started process 16993 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyY0PNl/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:17:10 INFO - PROCESS | 16993 | 13:17:10 INFO - PROCESS | 16993 | (process:17056): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:17:20 INFO - PROCESS | 16993 | RSS: Main: 138948608 13:17:20 INFO - PROCESS | 16993 | 13:17:43 INFO - PROCESS | 16993 | Cycle 1(1): loaded http://localhost:42510/tests/v8_7/run.html (next: http://localhost:42510/tests/v8_7/run.html) 13:17:43 INFO - PROCESS | 16993 | RSS: Main: 142745600 13:17:43 INFO - PROCESS | 16993 | 13:17:43 INFO - PROCESS | 16993 | __start_tp_report 13:17:43 INFO - PROCESS | 16993 | _x_x_mozilla_page_load 13:17:43 INFO - PROCESS | 16993 | _x_x_mozilla_page_load_details 13:17:43 INFO - PROCESS | 16993 | |i|pagename|runs| 13:17:43 INFO - PROCESS | 16993 | |0;Richards;165.45334215751157 13:17:43 INFO - PROCESS | 16993 | |1;DeltaBlue;168.69095816464238 13:17:43 INFO - PROCESS | 16993 | |2;Encrypt;279.09572983533354 13:17:43 INFO - PROCESS | 16993 | |3;Decrypt;5191.709844559586 13:17:43 INFO - PROCESS | 16993 | |4;RayTrace;920.8103130755064 13:17:43 INFO - PROCESS | 16993 | |5;Earley;553.0973451327434 13:17:43 INFO - PROCESS | 16993 | |6;Boyer;10670.212765957447 13:17:43 INFO - PROCESS | 16993 | |7;RegExp;39211.53846153846 13:17:43 INFO - PROCESS | 16993 | |8;Splay;524.6589716684156 13:17:43 INFO - PROCESS | 16993 | |9;NavierStokes;4817.307692307692 13:17:43 INFO - PROCESS | 16993 | __end_tp_report 13:17:43 INFO - PROCESS | 16993 | __startTimestamp1458764263581__endTimestamp 13:17:43 INFO - PROCESS | 16993 | 13:17:43 INFO - PROCESS | 16993 | ------- Summary: start ------- 13:17:43 INFO - PROCESS | 16993 | Number of tests: 10 13:17:43 INFO - PROCESS | 16993 | 13:17:43 INFO - PROCESS | 16993 | [#0] Richards Cycles:1 Average:165.45 Median:165.45 stddev:0.00 (0.0%) 13:17:43 INFO - PROCESS | 16993 | Values: 165.5 13:17:43 INFO - PROCESS | 16993 | 13:17:43 INFO - PROCESS | 16993 | [#1] DeltaBlue Cycles:1 Average:168.69 Median:168.69 stddev:0.00 (0.0%) 13:17:43 INFO - PROCESS | 16993 | Values: 168.7 13:17:43 INFO - PROCESS | 16993 | 13:17:43 INFO - PROCESS | 16993 | [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 13:17:43 INFO - PROCESS | 16993 | Values: 279.1 13:17:43 INFO - PROCESS | 16993 | 13:17:43 INFO - PROCESS | 16993 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 13:17:43 INFO - PROCESS | 16993 | Values: 5191.7 13:17:43 INFO - PROCESS | 16993 | 13:17:43 INFO - PROCESS | 16993 | [#4] RayTrace Cycles:1 Average:920.81 Median:920.81 stddev:0.00 (0.0%) 13:17:43 INFO - PROCESS | 16993 | Values: 920.8 13:17:43 INFO - PROCESS | 16993 | 13:17:43 INFO - PROCESS | 16993 | [#5] Earley Cycles:1 Average:553.10 Median:553.10 stddev:0.00 (0.0%) 13:17:43 INFO - PROCESS | 16993 | Values: 553.1 13:17:43 INFO - PROCESS | 16993 | 13:17:43 INFO - PROCESS | 16993 | [#6] Boyer Cycles:1 Average:10670.21 Median:10670.21 stddev:0.00 (0.0%) 13:17:43 INFO - PROCESS | 16993 | Values: 10670.2 13:17:43 INFO - PROCESS | 16993 | 13:17:43 INFO - PROCESS | 16993 | [#7] RegExp Cycles:1 Average:39211.54 Median:39211.54 stddev:0.00 (0.0%) 13:17:43 INFO - PROCESS | 16993 | Values: 39211.5 13:17:43 INFO - PROCESS | 16993 | 13:17:43 INFO - PROCESS | 16993 | [#8] Splay Cycles:1 Average:524.66 Median:524.66 stddev:0.00 (0.0%) 13:17:43 INFO - PROCESS | 16993 | Values: 524.7 13:17:43 INFO - PROCESS | 16993 | 13:17:43 INFO - PROCESS | 16993 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 13:17:43 INFO - PROCESS | 16993 | Values: 4817.3 13:17:43 INFO - PROCESS | 16993 | -------- Summary: end -------- 13:17:43 INFO - PROCESS | 16993 | 13:17:44 INFO - TEST-INFO | 16993: exit 0 13:17:44 INFO - TEST-OK | v8_7 | took 40907ms 13:17:44 INFO - SUITE-END | took 1207s 13:17:44 INFO - Completed test suite (00:20:07) 13:17:44 INFO - Working with test: dromaeo_css 13:17:44 INFO - Generating results file: dromaeo_css 13:17:44 INFO - Working with test: kraken 13:17:44 INFO - Generating results file: kraken 13:17:44 INFO - javascript benchmark 13:17:44 INFO - Working with test: v8_7 13:17:44 INFO - Generating results file: v8_7 13:17:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:17:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,53,43]] 13:17:44 INFO - process_Request line: dromaeo_css 7046.44 graph.html#tests=[[72,53,43]] 13:17:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:17:44 INFO - process_Request line: kraken 1501.40 graph.html#tests=[[232,53,43]] 13:17:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:17:44 INFO - process_Request line: v8_7 22192.11 graph.html#tests=[[230,53,43]] 13:17:44 INFO - RETURN: dromaeo_css: 7046.44 13:17:44 INFO - RETURN: kraken: 1501.40 13:17:44 INFO - RETURN: v8_7: 22192.11 13:17:44 INFO - javascript benchmark 13:17:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3231.7899336543123, 3265.9510107348387, 3273.9508907366394, 3274.132354925945, 3306.553615261939, 5237.266782650428, 5258.4215736269025, 5259.9474005259935, 5266.631335806495, 5301.681899086047, 5229.0, 5232.0320740663, 5262.394824595172, 5266.552343050836, 5277.551408130304, 4789.568938795499, 4833.081714474256, 4889.755512224375, 4895.657303988723, 4971.875703107415, 4740.857774266778, 4807.110684523357, 4862.878428039309, 4886.63350248731, 4956.231784073474, 4884.19410797218, 4919.877003074916, 4940.3330550375595, 4951.356323677935, 4957.702537847741, 4849.199882019462, 4871.2206047032305, 4887.804487820483, 4914.287428322873, 4923.458419573862, 4713.505081966413, 4779.3070004849105, 4782.378290822171, 4809.398825146856, 4841.007593443371, 5070.138076527, 5081.0, 5123.923141152885, 5127.102757017545, 5133.897322053538, 5631.662100273997, 5648.068068768648, 5649.378568357477, 5656.2929633795775, 5657.745401456944, 5535.58483113768, 5555.666660000373, 5611.130274807411, 5611.7474713637985, 5709.628874123168, 5291.391489978663, 5374.167004114369, 5375.16684913839, 5384.6769193848495, 5411.540019098381, 5687.146927960839, 5739.081746920556, 5746.856328591819, 5755.510781583613, 5775.682337471395, 5408.8377348679605, 5473.644213126134, 5521.0, 5541.889162216733, 5544.944550554443, 5575.163725441135, 5634.352049514358, 5636.126400407861, 5637.295338082739, 5638.984982703153, 5556.222128901957, 5564.693941833238, 5569.303837020372, 5585.301837270341, 5590.273264475592, 5417.26866872975, 5556.083246264402, 5556.333240011225, 5559.388467268597, 5616.719164041863, 4401.18578063053, 4404.6256068233915, 4406.140802543538, 4409.3606427068535, 4417.514073451917, 3972.523297204354, 3978.3236849735613, 3984.362501999724, 3989.7207195496035, 3993.900152496211, 5375.19372094189, 5461.644993075437, 5462.754176062087, 5464.562834973192, 5543.390227075019, 5664.801731939445, 5683.431656834367, 5687.118496633028, 5687.544996400278, 5687.573431992534, 5454.61817672767, 5457.263269458573, 5457.808976685797, 5457.808976685797, 5516.586256030814, 4798.136335459581, 4808.855734327975, 4813.03739252151, 4892.315075889378, 4980.2778597103215, 5838.649681019152, 5845.240118784616, 5854.619449735838, 5864.67744274069, 5874.353821079678, 5643.068893632669, 5646.265985422033, 5650.717464126859, 5662.8301150965535, 5664.546836253007, 5681.233033540584, 5731.340895797037, 5783.537317014713, 5833.883322333445, 5850.327212370632, 5614.382417934105, 5630.859228519156, 5638.407967163389, 5649.322081350264, 5651.180578816131, 5561.165825126263, 5597.552195824405, 5709.9714501427225, 5722.998475266895, 5731.971340143273, 5453.481919217668, 5454.154606036071, 5519.558435325244, 5575.944240557543, 5599.272094627672, 5567.498925096761, 5572.3034620672415, 5574.637648552831, 5586.748596313095, 5605.80379686709, 5382.4886635769535, 5474.945250547444, 5492.423295553909, 5496.422875598005, 5528.226048353315, 5477.424870388551, 5532.446755324436, 5563.109902415594, 5570.303712035996, 5583.804566840141, 5452.563794896478, 5479.452054794648, 5488.313960754906, 5506.0, 5508.91736623943], "unit": "score", "name": "dojo.html", "value": 5235.861373615225}, {"lowerIsBetter": false, "replicates": [545.9454054594542, 547.4771593128563, 574.7499837570655, 581.8545363659085, 581.9621724587904, 37487.25025499492, 38516.42225366615, 38524.807375963115, 38552.0, 38641.420378694274, 38450.615493845056, 38627.420588691195, 38912.41631375532, 38984.0, 39054.41418378727, 8443.577821108935, 8595.5702214889, 8600.827983440327, 8637.52493612851, 8639.136086391341, 8436.873446898302, 8746.781330466725, 8753.562321883881, 8765.298776097898, 8777.473351598925, 8700.912990870074, 8812.030676625565, 8812.1187881212, 8835.469871807712, 8840.160184782435, 8685.435446695945, 8740.737777866643, 8745.344099192585, 8803.207711306013, 8805.339599530029, 8555.95722021392, 8605.354598405145, 8658.437201581877, 8697.173768491983, 8705.129487051245, 38847.22305553901, 39117.804410978046, 39189.0, 39315.0, 39435.802820986, 3396.626371099177, 3419.4186988212064, 3610.422332426799, 3759.887203383903, 4078.775667338295, 31685.52471712926, 31761.523577146363, 31798.364032719215, 32257.354852902812, 32482.35035299281, 3771.528558930134, 3885.2812229737588, 3898.064464528521, 3926.2147570486018, 3970.682345412389, 275080.0, 277189.0, 277369.0, 277427.0, 278106.0, 44796.0, 45249.77375113103, 45709.0, 45717.54282457133, 45927.081458370645, 41677.79161104175, 41815.0, 42089.368659470136, 42177.15645687069, 42224.15551688949, 16414.09722465276, 16803.663926721398, 16820.15899205035, 16824.242909069122, 16857.157142142845, 13532.255725935169, 13535.864641353657, 13584.049116561944, 13615.0, 13977.58067257984, 15234.619134521725, 15357.692846143238, 15363.231838408035, 15383.46157884491, 15391.461298854487, 5692.658440493501, 5872.153739300765, 5899.4985426239255, 5912.970435147797, 5921.407859214044, 958.1137447860701, 983.3706427886159, 1050.2910535388583, 1055.298226679265, 1077.3159044006954, 26405.33986650349, 26803.865980669972, 26958.191254262405, 27113.45773084567, 31316.9039083631, 1086.6414083352474, 1136.170595465315, 1146.2091157101572, 1160.988390116088, 1198.4606926882936, 14275.928620356832, 14485.78271325931, 14542.927285363505, 14686.339114739862, 14828.925855370655, 441564.0, 509363.0, 511286.0, 511488.0, 750871.0, 54453.45546544563, 55161.172582411295, 55304.72347638236, 55516.72241638766, 55596.0, 1458.649924018228, 1481.444458328127, 1489.0618910086575, 1495.5064828606535, 1497.490853109926, 29496.705032950253, 30625.0, 30928.845355773075, 31246.843765781025, 31533.211669708442, 48196.7590162047, 48650.270245945634, 49115.0, 49119.508804912926, 49187.75406122946, 286733.0, 286852.0, 286956.0, 287691.0, 287897.0, 34083.659163409044, 45157.77421112874, 45362.865928352054, 45634.08731825411, 46264.30603541017, 42174.57825421829, 42599.0, 42743.572564273956, 42986.140277193655, 43055.569444305154, 36418.4537231947, 36488.0, 37131.25737485289, 37625.0, 37784.62215377921, 39491.80254098711, 39693.404598930465, 39993.60006400015, 40063.79968100141, 40991.59008409997, 35873.46189807103, 36221.81889090538, 36385.818070909474, 36615.45076823796, 36632.26735465329, 31298.0, 32786.836065819516, 34801.12997175091, 35029.29941401107, 42400.36399453949, 30503.237419064702, 30534.694653053186, 30927.536086959164, 33225.667743323225, 33437.33125337528], "unit": "score", "name": "ext.html", "value": 18860.93668269043}, {"lowerIsBetter": false, "replicates": [385.66061865558305, 387.45755941681654, 389.27507447864946, 389.66099493440703, 397.62225885408833, 15791.921040394811, 16051.83948160518, 17437.389691360804, 18051.187696553654, 18153.27386904524, 16906.647468202544, 17169.0, 17731.64536709265, 17738.82261177391, 18033.09834508276, 5130.410002849673, 5369.355677318727, 5595.524380427648, 5600.0, 5601.467860553262, 5356.38401583819, 5537.750801213955, 5549.445055494459, 5580.497755202031, 5592.161175823619, 5385.865353366158, 5542.91685624714, 5567.916481252784, 5574.247476590669, 5600.747966341524, 5536.335639723239, 5561.165825126223, 5583.553315734732, 5597.468240517144, 5613.298337707786, 5348.358197016344, 5392.0, 5550.306211723535, 5556.222128901957, 5558.138488534284, 13418.664533386645, 13576.660583485393, 19898.20407183711, 20024.49938751543, 20573.07421166051, 2143.185589475989, 2164.3723320237114, 2194.8024677778917, 2272.625016872214, 2301.7583153768783, 11049.889501104966, 13365.131266467648, 13658.795118073236, 13684.52104176349, 13957.092788968685, 1914.636219118363, 1947.4936516505811, 1965.0764140853776, 2005.0776642744356, 2067.5348046689523, 61144.0, 61319.38680613226, 61729.382706172815, 62210.18396584058, 62667.37332626661, 11006.834897476545, 11006.944965275123, 11014.779704405866, 11023.283486573348, 11048.834267485994, 14389.928050359891, 14510.927445362706, 14541.127532347882, 14608.634784130481, 14616.780748288784, 8195.303399211014, 8242.711505097293, 8275.420720549624, 8294.37792165578, 8326.5004099753, 7916.485428447248, 7918.168592297841, 7926.643301051467, 7928.0, 7967.760967170994, 4601.792919318572, 4763.404574428197, 4857.295692124622, 4886.096072226649, 4920.040592084581, 1833.1750712179573, 1836.5133239691493, 1947.74679291694, 1961.9895753686862, 1973.181129831104, 909.7088931541844, 981.2738573455591, 1076.160594736107, 1086.255914698434, 1086.4024786367465, 16225.51323460298, 16770.664586708197, 17182.22679979404, 17498.300067997137, 17944.641107177784, 978.2125389061873, 1032.6488993742164, 1057.471264367816, 1061.4374381577777, 1063.3513556730388, 8977.730668079968, 9240.0, 9312.627494900127, 9327.580258888367, 9474.336796424184, 569778.0, 571490.0, 575513.0, 597299.0, 602433.0, 69098.30901691019, 69392.0, 70086.29913700798, 73160.0, 73324.2667573328, 1194.4266751959108, 1211.255078126963, 1217.3183017510223, 1220.45079714129, 1230.5508489401484, 14888.776668349767, 14989.700205995601, 15029.323680434625, 15142.0, 15171.0, 35748.28503429969, 35793.0, 36256.09359766027, 36369.454458183674, 37036.44445333376, 45428.31857522206, 46123.3081503771, 46981.765091174326, 47569.52430475789, 47892.0, 7380.298871607189, 7468.066491688539, 7529.284717951786, 7557.584332861526, 7592.734254301073, 11063.668089957315, 11108.722281942693, 11500.769984600429, 11622.6513204604, 12102.092343074128, 9994.350367226107, 10169.491525423848, 10550.31422957536, 10586.89413105859, 10738.785224295314, 10294.124999374837, 10474.476276186313, 10477.214208934209, 10520.789584208425, 10774.353538787698, 9812.607495700093, 9917.404955702681, 10234.0, 10642.787144257227, 10687.625933092304, 7374.727993561247, 7778.377729781717, 7830.725924592612, 7882.881756773539, 8057.0734365548715, 7446.888296675445, 7582.54504729718, 9876.358036727877, 10598.0, 10637.521311541153], "unit": "score", "name": "jquery.html", "value": 8651.72007520541}, {"lowerIsBetter": false, "replicates": [1513.6594266290085, 1528.88533359998, 1714.1600615698312, 1829.5426143464133, 1851.9444416667504, 7658.617069146541, 7668.271514206149, 7713.42149338799, 7821.491603045798, 7914.841703165933, 7546.773596792092, 7574.659140338684, 7609.3532049775695, 7623.428242881779, 7643.9235607643905, 2271.3980795089315, 2280.749117597063, 2281.315605318406, 2287.039443433762, 2292.266474728088, 2202.812760915324, 2254.7407048189502, 2331.8717470539113, 2333.603287441139, 2346.061575369857, 2261.604219261631, 2277.6355783074628, 2291.4844160063935, 2313.2366319114653, 2313.375388645065, 2284.6116160252795, 2298.9425264368356, 2299.8620082795, 2325.1164557468137, 2326.1277021117166, 2311.66480860276, 2312.190733243368, 2314.0628045641542, 2315.4790172211287, 2321.802646775026, 7685.730999414994, 7712.113106992655, 7712.190220026872, 7732.45872788905, 7777.844443111106, 4654.743989080599, 4710.929336059928, 4739.715617062987, 4741.0, 4744.715317080986, 2872.5834753960767, 2910.3306239565018, 2980.478416277143, 2993.0, 3003.189138932498, 925.1257561604286, 939.9530023498797, 954.0983770337034, 977.7457860956132, 984.547108330169, 10582.68251952435, 10662.520186591622, 10714.303570267986, 10738.624148154855, 10742.3017503862, 3994.500687414073, 4025.1345960618023, 4074.0, 4082.408050832613, 4084.4894388201474, 8757.737267881974, 8834.469931804113, 8843.248323892412, 8847.911520884709, 8860.8670869937, 4625.098105869391, 4639.072185562901, 4640.721556706609, 4663.230566956482, 4664.86005419838, 4252.298370768788, 4270.0605866709275, 4273.166732487135, 4314.050908800059, 4323.870283891489, 3321.9169520762175, 3339.7328213743326, 3349.0, 3362.81504517249, 3388.542546756206, 971.5093877591771, 979.1530326267728, 987.8814542254831, 996.5465713100667, 1061.442742560162, 1032.5353590884133, 1041.245097304448, 1050.1808589300358, 1227.1532642476664, 1408.542223777256, 6935.6878940447805, 6973.546719463218, 6976.058232138698, 6982.546134501241, 7011.89482157768, 1198.3049831097942, 1221.91446598739, 1223.2782658231686, 1223.62067758995, 1224.3510939202238, 5727.6849773262875, 5782.277215348082, 5800.854978625568, 5802.622829516153, 5805.593608447368, 8325.250727434439, 8850.955745221232, 8852.557372131369, 8916.420432671985, 8957.910420895707, 8863.955680221557, 8904.154105359981, 8939.106089391138, 8986.910130898737, 9036.412633178954, 7372.152202496674, 7373.0, 7447.292507211914, 7524.247575242432, 7553.206913274027, 7032.437405007689, 7035.12060992376, 7090.361867431956, 7105.46708996817, 7114.0, 8127.634256458592, 8226.465279756796, 8528.701495447629, 8556.486610803371, 8583.914160858312, 8501.19238672325, 8526.275266602408, 8592.699255526026, 8602.741917742478, 8709.259712924219, 6814.216365117876, 6995.405390541861, 6996.545224560387, 7009.369156775914, 7028.121484814398, 7133.322334378433, 7163.10461192351, 7165.7850264492145, 7175.390091842252, 7208.45936554771, 6591.604503729792, 6632.635205063768, 6731.798046058626, 6792.456603471809, 6851.623160726208, 6376.0, 6452.806415807533, 6466.579672321284, 6563.835904102436, 6586.242582103119, 6674.632895190617, 6755.392014718699, 6766.5263431559315, 6771.796846094428, 6774.153230846145, 6225.564210505402, 6253.530985176039, 6266.749330026931, 6281.3404592518955, 6290.905636415366, 6383.904241436475, 6423.486121110206, 6452.870942581216, 6484.805455836144, 6608.603483790988], "unit": "score", "name": "mootools.html", "value": 4418.077354116623}, {"lowerIsBetter": false, "replicates": [331.1720698254364, 334.91961929137017, 335.8387973772589, 352.2215902854691, 355.1565033046514, 6257.092721555383, 6287.968560157198, 6288.402601752838, 6373.107764912905, 6387.393197646228, 6054.243219597551, 6157.692115394235, 6189.597676151047, 6229.4704950079185, 6231.937680623192, 4829.22732362822, 4831.396075490564, 4833.782479788418, 4841.273808928671, 4843.104025755229, 4840.9515904840855, 4841.225403935371, 4844.32179494871, 4846.200376937819, 4846.321514987904, 4716.4340279166545, 4793.90412191756, 4802.303665968432, 4818.036392721452, 4823.155947709137, 4775.164346239429, 4791.28130780384, 4799.256115302133, 4804.855854324376, 4805.495422980589, 4241.49102107746, 4245.681573881971, 4249.277622804131, 4250.256205164084, 4251.851185208503, 5956.434138756811, 5957.1957785698805, 5961.880762384728, 5987.880242395171, 5992.910106348409, 5521.889562208774, 5616.887662246773, 5637.633553818989, 5658.603897727161, 5662.094064949588, 6632.436242919358, 6665.166854143232, 6669.199696036459, 6690.0, 6699.39705426509, 4717.0, 4722.8110875564935, 4727.574518293336, 4730.314104454869, 4741.122892264908, 6832.863342733118, 6939.028536005014, 6986.37122658958, 7026.0, 7026.191987921404, 4601.884952876205, 4660.883477913079, 4671.953280467152, 4683.7892294846815, 4695.3191787191345, 4725.196716558194, 4735.360726301974, 4753.952460475421, 4754.762261886892, 4767.499412561631, 5533.501984821305, 5538.141588053778, 5544.750486228129, 5544.91682624761, 5553.083741182741, 6593.835154121185, 6739.393454589111, 6742.662866856637, 6750.493712971547, 6750.628715420699, 1648.8021437427585, 1676.430013795291, 1699.6345785656142, 1701.9404320848712, 1703.8892471989282, 1130.4856290387854, 1132.049078773834, 1135.4720055174384, 1137.778133264022, 1142.3260276436943, 6537.444317233088, 6540.836479087966, 6569.981652843817, 6573.57271777333, 6591.538592298589, 6852.143482064742, 6886.345797149263, 6891.689873955584, 6903.5167538271835, 6912.516123871382, 6479.611223326616, 6490.610563366213, 6495.837604059841, 6541.771038013647, 6560.540762146699, 3747.887563373103, 3763.5295588051495, 3771.849126034928, 3777.99883030997, 3791.2227993261317, 7231.819204519824, 7284.0, 7300.780976570712, 7318.634068296564, 7344.48588598793, 7066.787996360117, 7211.0, 7220.277972202738, 7221.24176961422, 7239.9276007240305, 7291.781246562506, 7317.304856038668, 7325.304096110861, 7328.047353843966, 7337.816554586178, 6995.195552511526, 7018.227994920657, 7026.262242464468, 7027.297270272932, 7030.929690703232, 6723.193216813818, 6868.9313106870295, 6923.307669233238, 6930.27232140618, 6935.445164386736, 7327.926720732938, 7350.96324518374, 7351.3751331137455, 7360.116785985716, 7385.076865391826, 4709.576138147583, 4748.0, 4756.048790242035, 4786.1863483208635, 4787.281907713732, 6911.3779759821855, 6945.131858517685, 7064.187618423947, 7066.540674856118, 7086.468514861509, 6837.247902730795, 6845.657717114024, 6868.072810170763, 6891.586504809728, 6897.55165914214, 6846.897296540656, 6855.108835851307, 6868.828279292858, 6875.7937261882225, 6889.483288753263, 6508.186476690414, 6647.102641143384, 6668.199816022108, 6680.365365290289, 6738.9891516272955, 6788.76239331621, 6814.2163651180745, 6815.216250131299, 6863.828404289933, 6882.070920425678, 6687.264400915993, 6703.899441508479, 6726.159230096238, 6742.93257067423, 6744.0558321834005], "unit": "score", "name": "prototype.html", "value": 5080.473153926523}, {"lowerIsBetter": false, "replicates": [786.7954331873711, 799.272661877691, 802.3541049455187, 810.1048341582551, 840.7393707950536, 12134.878651213485, 12154.69613259669, 12226.327551984648, 12243.877561224384, 12267.447964841582, 13355.53255636053, 13477.0, 13518.053736238468, 13519.0, 13519.12125711828, 883.2624758326805, 912.9817403651923, 917.3349321741717, 919.296737995434, 921.1341339141186, 879.5821984557316, 896.5158814240302, 896.5920506169678, 898.9955050224739, 899.9775005624879, 930.6417029443679, 939.9389039712397, 940.8541676040225, 941.6421759731293, 943.4999450291357, 929.6142101028065, 930.878985731854, 932.5523748600676, 934.0985948559672, 936.6815282803811, 684.4968947823346, 690.9930900690979, 691.0705101638289, 691.4261163234554, 692.7506097804786, 14710.779338309934, 14794.112353258839, 14818.110913345234, 14835.48075817352, 14874.405023799036, 13131.146475479063, 13136.474541018348, 13147.211167329991, 13329.73340533184, 13364.465421383133, 9585.568649410723, 9652.179564737005, 9681.41911485306, 9759.072888075621, 9788.902110978941, 3632.0738211755834, 3649.4525821126776, 3665.193657395369, 3685.9262814743556, 3695.6489133532273, 48936.26595601069, 49216.0, 50083.999999999636, 50244.74877625588, 50649.24026139611, 10286.588536458608, 10560.841587376195, 10570.312929659547, 10636.574537018432, 10829.24195306321, 18524.25902963893, 18562.907185463988, 18641.627167456576, 18737.437876863714, 18867.811321886606, 7589.506682065648, 7711.305982461606, 7839.25527074927, 7897.17079706634, 7992.3606111510935, 3916.1971795781797, 3943.881683549498, 3944.447777311179, 3950.486436763202, 3976.2445135424177, 3012.638483382008, 3017.09487153853, 3046.8933587324336, 3047.1924939890505, 3058.525928481089, 536.7074944155445, 559.5216090242784, 563.7096895099028, 581.3140494216865, 583.375787906944, 516.7648719832467, 528.6854321678595, 596.4602035158189, 601.5728832528954, 644.7388807532957, 7844.803879902934, 8170.836583268301, 9081.318901082444, 9253.213476854542, 9330.253579713606, 527.6359312074657, 534.6097348935222, 578.945000224978, 581.9621724587888, 710.7512370670224, 3746.4754934309217, 3989.880303590839, 4056.675465962775, 4180.1012782251355, 4292.914141717149, 50949.490505095215, 51296.23055654168, 51563.48436515662, 52016.479835201164, 52019.73990130025, 47087.76456117698, 47112.5288747115, 47182.528174717816, 47646.28530572044, 47873.28190077082, 45276.77361613237, 45548.3167752484, 45575.544244557794, 45989.54010459853, 46369.76815115903, 8016.158303378062, 8422.831543368975, 8468.449550779425, 8575.61409736551, 8602.225799678059, 34149.82925085359, 34609.65390346065, 35057.298854023284, 35701.82149089238, 36153.819230903675, 40772.59227407688, 41451.37822932598, 44739.0, 44745.0, 44786.104277913604, 10915.727106822393, 11089.390083545482, 11112.611058612909, 11118.555257789598, 11361.375124367909, 12441.875581244434, 12750.171238869443, 12950.222986620833, 13046.869531304565, 13414.195148291134, 10914.290571112851, 11399.943000284946, 11472.713182170179, 11669.299842009506, 12100.213486123374, 11509.309441433541, 11534.538618455168, 11594.768104637691, 11849.229800063313, 11856.644300670994, 11714.472848721658, 11871.584494542994, 11901.345426001653, 12037.337946413032, 12049.216800907912, 9420.858687119835, 9460.479673617741, 9829.705108846745, 10014.799704005733, 10027.749306267402, 10098.646547370807, 10326.741831454274, 10411.94794026025, 10476.738081548023, 10518.684439466828], "unit": "score", "name": "yui.html", "value": 6382.449146813126}], "name": "dromaeo_css", "value": 7046.435494436763}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 113.0, 111.0, 111.0, 121.0, 109.0, 112.0, 112.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [157.0, 126.0, 151.0, 162.0, 125.0, 163.0, 150.0, 129.0, 169.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 163.0, 163.0, 165.0, 163.0, 162.0, 162.0, 166.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 76.0, 155.0, 77.0, 77.0, 76.0, 76.0, 153.0, 76.0], "unit": "score", "name": "audio-fft", "value": 91.2}, {"lowerIsBetter": true, "replicates": [104.0, 97.0, 137.0, 96.0, 95.0, 96.0, 142.0, 95.0, 96.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [57.0, 60.0, 57.0, 61.0, 56.0, 60.0, 58.0, 57.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 57.5}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 63.0, 65.0, 65.0, 64.0, 64.0, 64.0, 69.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.6}, {"lowerIsBetter": true, "replicates": [86.0, 79.0, 81.0, 83.0, 82.0, 86.0, 79.0, 83.0, 80.0, 80.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.9}, {"lowerIsBetter": true, "replicates": [116.0, 123.0, 110.0, 119.0, 111.0, 110.0, 127.0, 116.0, 108.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.3}, {"lowerIsBetter": true, "replicates": [147.0, 138.0, 138.0, 136.0, 141.0, 137.0, 135.0, 144.0, 140.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.5}, {"lowerIsBetter": true, "replicates": [65.0, 68.0, 67.0, 66.0, 64.0, 69.0, 66.0, 65.0, 69.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.3}], "name": "kraken", "value": 1501.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.45334215751157], "unit": "score", "name": "Richards", "value": 213.36528799999996}, {"lowerIsBetter": false, "replicates": [168.69095816464238], "unit": "score", "name": "DeltaBlue", "value": 391.9475040000001}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [920.8103130755064], "unit": "score", "name": "RayTrace", "value": 803.6280540000001}, {"lowerIsBetter": false, "replicates": [553.0973451327434], "unit": "score", "name": "Earley", "value": 1204.9651040000003}, {"lowerIsBetter": false, "replicates": [10670.212765957447], "unit": "score", "name": "Boyer", "value": 62.46014157527414}, {"lowerIsBetter": false, "replicates": [39211.53846153846], "unit": "score", "name": "RegExp", "value": 23.232574791564506}, {"lowerIsBetter": false, "replicates": [524.6589716684156], "unit": "score", "name": "Splay", "value": 155.321846}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 22192.105771688177}]} 13:17:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,43]]", "result": "22192.11"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,43]]", "result": "1501.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,43]]", "result": "7046.44"}}} 13:17:45 INFO - Return code: 0 13:17:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:17:45 INFO - # TBPL SUCCESS # 13:17:45 INFO - Running post-action listener: _resource_record_post_action 13:17:45 INFO - Running post-run listener: _resource_record_post_run 13:17:46 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 461561856; Read time: 12; Write time: 607456 13:17:46 INFO - install - Wall time: 13s; CPU: 15.0%; Read bytes: 0; Write bytes: 234553344; Read time: 0; Write time: 425148 13:17:46 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 226672640; Read time: 12; Write time: 182284 13:17:46 INFO - Running post-run listener: _upload_blobber_files 13:17:46 INFO - Blob upload gear active. 13:17:46 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:17: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 13:17: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'] 13:17: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 13:17:46 INFO - (blobuploader) - INFO - Open directory for files ... 13:17:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:17:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:17:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:47 INFO - (blobuploader) - INFO - Done attempting. 13:17:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:17:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:17:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:48 INFO - (blobuploader) - INFO - Done attempting. 13:17:48 INFO - (blobuploader) - INFO - Iteration through files over. 13:17:48 INFO - Return code: 0 13:17:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:17:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:17:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fbdd0ea96e2d19904b329c5bb1951fb2229c786c7128565a1172c2960e62d0443b37b3b10fd0926d396eb5a9227c7afb1b8692d8a6dff12e9015d6f1ebf4c5c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b257b3d617a103c12b03f94fdfb4f37fd826d361e0772c2a89f241264fd3550985a14447a52a7cee86f4b8104c1d55498e72951377deb514a9896a878fc87dee"} 13:17:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:17:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:17:48 INFO - Contents: 13:17:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fbdd0ea96e2d19904b329c5bb1951fb2229c786c7128565a1172c2960e62d0443b37b3b10fd0926d396eb5a9227c7afb1b8692d8a6dff12e9015d6f1ebf4c5c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b257b3d617a103c12b03f94fdfb4f37fd826d361e0772c2a89f241264fd3550985a14447a52a7cee86f4b8104c1d55498e72951377deb514a9896a878fc87dee"} 13:17:48 INFO - Running post-run listener: copy_logs_to_upload_dir 13:17:48 INFO - Copying logs to upload dir... 13:17:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 13:17:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.383388 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-23 13:17:48.167308) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 13:17:48.171080) ========= 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=aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fbdd0ea96e2d19904b329c5bb1951fb2229c786c7128565a1172c2960e62d0443b37b3b10fd0926d396eb5a9227c7afb1b8692d8a6dff12e9015d6f1ebf4c5c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b257b3d617a103c12b03f94fdfb4f37fd826d361e0772c2a89f241264fd3550985a14447a52a7cee86f4b8104c1d55498e72951377deb514a9896a878fc87dee"} build_url:https://queue.taskcluster.net/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/eqi-TdmgQQ-V5tsJRn6XqA/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fbdd0ea96e2d19904b329c5bb1951fb2229c786c7128565a1172c2960e62d0443b37b3b10fd0926d396eb5a9227c7afb1b8692d8a6dff12e9015d6f1ebf4c5c5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b257b3d617a103c12b03f94fdfb4f37fd826d361e0772c2a89f241264fd3550985a14447a52a7cee86f4b8104c1d55498e72951377deb514a9896a878fc87dee"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 13:17:48.200902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 13:17:48.201403) ========= 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=aa52b8aba932b19cc50b5275000001de-1458762715.874483-1499765565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 13:17:48.285310) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 13:17:48.286022) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 13:17:48.286667) ========= ========= Total master_lag: 0.32 =========