builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1458071870.66 results: success (0) buildid: 20160315101834 builduid: 459b21d2c8fd4d7993fe0574f4f8b7dd revision: 59d1a8971a8ca27376bde5d16fc76b4cbb39da7c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:50.658713) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:50.659285) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:50.659623) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005394 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:50.681794) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:50.682141) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:50.696176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:50.696495) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004588 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:50.745337) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:50.745661) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:50.746089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:50.746433) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-15 12:57:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-03-15 12:57:50 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102860 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:50.862336) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:50.862775) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019975 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:50.912392) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-15 12:57:50.912780) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 59d1a8971a8ca27376bde5d16fc76b4cbb39da7c --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 59d1a8971a8ca27376bde5d16fc76b4cbb39da7c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-15 12:57:51,047 truncating revision to first 12 chars 2016-03-15 12:57:51,048 Setting DEBUG logging. 2016-03-15 12:57:51,048 attempt 1/10 2016-03-15 12:57:51,048 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/59d1a8971a8c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 12:57:52,309 unpacking tar archive at: mozilla-beta-59d1a8971a8c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.575867 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-15 12:57:52.503293) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:52.503703) ========= echo 59d1a8971a8ca27376bde5d16fc76b4cbb39da7c in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'59d1a8971a8ca27376bde5d16fc76b4cbb39da7c'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 59d1a8971a8ca27376bde5d16fc76b4cbb39da7c program finished with exit code 0 elapsedTime=0.004860 script_repo_revision: '59d1a8971a8ca27376bde5d16fc76b4cbb39da7c' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:52.555637) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:52.555989) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 12:57:52.566964) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-15 12:57:52.567318) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:57:52 INFO - MultiFileLogger online at 20160315 12:57:52 in /builds/slave/test-pgo 12:57:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:57:52 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:57:52 INFO - {'append_to_log': False, 12:57:52 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:57:52 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:57:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:57:52 INFO - 'branch': 'Mozilla-Beta', 12:57:52 INFO - 'buildbot_json_path': 'buildprops.json', 12:57:52 INFO - 'config_files': ('talos/linux_config.py',), 12:57:52 INFO - 'default_actions': ('clobber', 12:57:52 INFO - 'read-buildbot-config', 12:57:52 INFO - 'download-and-extract', 12:57:52 INFO - 'populate-webroot', 12:57:52 INFO - 'create-virtualenv', 12:57:52 INFO - 'install', 12:57:52 INFO - 'run-tests'), 12:57:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:57:52 INFO - 'download_minidump_stackwalk': True, 12:57:52 INFO - 'download_symbols': 'ondemand', 12:57:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:57:52 INFO - 'tooltool.py': '/tools/tooltool.py', 12:57:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:57:52 INFO - '/tools/misc-python/virtualenv.py')}, 12:57:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:57:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:57:52 INFO - 'installer_path': 'installer.exe', 12:57:52 INFO - 'log_level': 'info', 12:57:52 INFO - 'log_name': 'talos', 12:57:52 INFO - 'log_to_console': True, 12:57:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:57:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:57:52 INFO - 'opt_config_files': (), 12:57:52 INFO - 'pip_index': False, 12:57:52 INFO - 'sps_profile': False, 12:57:52 INFO - 'sps_profile_interval': 0, 12:57:52 INFO - 'suite': 'dromaeojs', 12:57:52 INFO - 'system_bits': '32', 12:57:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:57:52 INFO - 'title': 'talos-linux64-ix-038', 12:57:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:57:52 INFO - 'use_talos_json': True, 12:57:52 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:57:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:57:52 INFO - 'work_dir': 'build'} 12:57:52 INFO - ##### 12:57:52 INFO - ##### Running clobber step. 12:57:52 INFO - ##### 12:57:52 INFO - Running pre-action listener: _resource_record_pre_action 12:57:52 INFO - Running main action method: clobber 12:57:52 INFO - rmtree: /builds/slave/test-pgo/build 12:57:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:57:53 INFO - Running post-action listener: _resource_record_post_action 12:57:53 INFO - ##### 12:57:53 INFO - ##### Running read-buildbot-config step. 12:57:53 INFO - ##### 12:57:53 INFO - Running pre-action listener: _resource_record_pre_action 12:57:53 INFO - Running main action method: read_buildbot_config 12:57:53 INFO - Using buildbot properties: 12:57:53 INFO - { 12:57:53 INFO - "project": "", 12:57:53 INFO - "product": "firefox", 12:57:53 INFO - "script_repo_revision": "production", 12:57:53 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:57:53 INFO - "repository": "", 12:57:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 12:57:53 INFO - "buildid": "20160315101834", 12:57:53 INFO - "pgo_build": "True", 12:57:53 INFO - "basedir": "/builds/slave/test-pgo", 12:57:53 INFO - "buildnumber": 125, 12:57:53 INFO - "slavename": "talos-linux64-ix-038", 12:57:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:57:53 INFO - "platform": "ubuntu64_hw", 12:57:53 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:57:53 INFO - "branch": "mozilla-beta", 12:57:53 INFO - "repo_path": "releases/mozilla-beta", 12:57:53 INFO - "revision": "59d1a8971a8ca27376bde5d16fc76b4cbb39da7c", 12:57:53 INFO - "stage_platform": "linux64-pgo", 12:57:53 INFO - "builduid": "459b21d2c8fd4d7993fe0574f4f8b7dd", 12:57:53 INFO - "slavebuilddir": "test" 12:57:53 INFO - } 12:57:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 12:57:53 INFO - Running post-action listener: _resource_record_post_action 12:57:53 INFO - ##### 12:57:53 INFO - ##### Running download-and-extract step. 12:57:53 INFO - ##### 12:57:53 INFO - Running pre-action listener: _resource_record_pre_action 12:57:53 INFO - Running main action method: download_and_extract 12:57:53 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:57:53 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:53 INFO - https://queue.taskcluster.net/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:57:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/test_packages.json 12:57:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/test_packages.json 12:57:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:57:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:57:53 INFO - Downloaded 1412 bytes. 12:57:53 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:57:53 INFO - Using the following test package requirements: 12:57:53 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:57:53 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:57:53 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:57:53 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:57:53 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 12:57:53 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:57:53 INFO - u'jsshell-linux-x86_64.zip'], 12:57:53 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:57:53 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:57:53 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:57:53 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:57:53 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 12:57:53 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:57:53 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 12:57:53 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:57:53 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:57:53 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 12:57:53 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 12:57:53 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:57:53 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:57:53 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:53 INFO - https://queue.taskcluster.net/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:57:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:57:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:57:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/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:57:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/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:57:54 INFO - Downloaded 23106125 bytes. 12:57:54 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:57:54 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:57:56 INFO - Return code: 0 12:57:56 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:57: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:57:56 INFO - https://queue.taskcluster.net/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:57:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:57:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 12:57:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/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:57:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/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:57:57 INFO - Downloaded 23106125 bytes. 12:57:57 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:57:57 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:57:59 INFO - Return code: 0 12:57:59 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:59 INFO - https://queue.taskcluster.net/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:57:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 12:57:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 12:57:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/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:57:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/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:58:00 INFO - Downloaded 10801536 bytes. 12:58:00 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:58:00 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:58:00 INFO - Return code: 0 12:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:00 INFO - https://queue.taskcluster.net/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:58:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:58:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:58:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/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:58:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dtxGPp8dRp6q3kjk67JZrg/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:58:01 INFO - Downloaded 52849420 bytes. 12:58:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:58:01 INFO - mkdir: /builds/slave/test-pgo/properties 12:58:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:58:01 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:58:01 INFO - Contents: 12:58:01 INFO - build_url:https://queue.taskcluster.net/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 12:58:02 INFO - Running post-action listener: _resource_record_post_action 12:58:02 INFO - Running post-action listener: set_extra_try_arguments 12:58:02 INFO - ##### 12:58:02 INFO - ##### Running populate-webroot step. 12:58:02 INFO - ##### 12:58:02 INFO - Running pre-action listener: _resource_record_pre_action 12:58:02 INFO - Running main action method: populate_webroot 12:58:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:58:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:58:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:58:02 INFO - '--tppagecycles', 12:58:02 INFO - '7'], 12:58:02 INFO - 'tests': ['tsvgm']}}, 12:58:02 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:58:02 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:58:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:58:02 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:58:02 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:58:02 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:58:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:58:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:02 INFO - 'talos_options': ['--e10s'], 12:58:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:58:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:02 INFO - 'tests': ['damp', 'tps']}, 12:58:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:02 INFO - 'talos_options': ['--e10s'], 12:58:02 INFO - 'tests': ['damp', 'tps']}, 12:58:02 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:58:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:58:02 INFO - 'other': {'tests': ['a11yr', 12:58:02 INFO - 'ts_paint', 12:58:02 INFO - 'tpaint', 12:58:02 INFO - 'sessionrestore', 12:58:02 INFO - 'sessionrestore_no_auto_restore']}, 12:58:02 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:58:02 INFO - 'tests': ['a11yr', 12:58:02 INFO - 'ts_paint', 12:58:02 INFO - 'tpaint', 12:58:02 INFO - 'sessionrestore', 12:58:02 INFO - 'sessionrestore_no_auto_restore']}, 12:58:02 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:58:02 INFO - 'tests': ['a11yr', 12:58:02 INFO - 'ts_paint', 12:58:02 INFO - 'tpaint', 12:58:02 INFO - 'sessionrestore', 12:58:02 INFO - 'sessionrestore_no_auto_restore']}, 12:58:02 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:58:02 INFO - 'tests': ['a11yr', 12:58:02 INFO - 'ts_paint', 12:58:02 INFO - 'tpaint', 12:58:02 INFO - 'sessionrestore', 12:58:02 INFO - 'sessionrestore_no_auto_restore']}, 12:58:02 INFO - 'other_l64': {'tests': ['a11yr', 12:58:02 INFO - 'ts_paint', 12:58:02 INFO - 'tpaint', 12:58:02 INFO - 'sessionrestore', 12:58:02 INFO - 'sessionrestore_no_auto_restore']}, 12:58:02 INFO - 'other_nol64': {'tests': ['a11yr', 12:58:02 INFO - 'ts_paint', 12:58:02 INFO - 'tpaint', 12:58:02 INFO - 'sessionrestore', 12:58:02 INFO - 'sessionrestore_no_auto_restore']}, 12:58:02 INFO - 'svgr': {'tests': ['tsvgx', 12:58:02 INFO - 'tsvgr_opacity', 12:58:02 INFO - 'tart', 12:58:02 INFO - 'tscrollx', 12:58:02 INFO - 'cart']}, 12:58:02 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:58:02 INFO - 'tests': ['tsvgx', 12:58:02 INFO - 'tsvgr_opacity', 12:58:02 INFO - 'tart', 12:58:02 INFO - 'tscrollx', 12:58:02 INFO - 'cart']}, 12:58:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:02 INFO - 'tests': ['tp5o']}, 12:58:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:02 INFO - 'talos_options': ['--e10s'], 12:58:02 INFO - 'tests': ['tp5o']}, 12:58:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:02 INFO - 'talos_options': ['--xperf_path', 12:58:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:58:02 INFO - 'tests': ['tp5n']}, 12:58:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:58:02 INFO - 'talos_options': ['--e10s', 12:58:02 INFO - '--xperf_path', 12:58:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:58:02 INFO - 'tests': ['tp5n']}}, 12:58:02 INFO - 'talos.zip': {'path': '', 12:58:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:58:02 INFO - Running post-action listener: _resource_record_post_action 12:58:02 INFO - ##### 12:58:02 INFO - ##### Running create-virtualenv step. 12:58:02 INFO - ##### 12:58:02 INFO - Running pre-action listener: _resource_record_pre_action 12:58:02 INFO - Running main action method: create_virtualenv 12:58:02 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:58:02 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:58:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:58:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:58:02 INFO - Using real prefix '/usr' 12:58:02 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:58:03 INFO - Installing distribute.............................................................................................................................................................................................done. 12:58:05 INFO - Installing pip.................done. 12:58:05 INFO - Return code: 0 12:58:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f622c66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2453850>, '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 0x23bf330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf7c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', '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:58:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 12:58:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:58:05 INFO - Using env: {'DISPLAY': ':0', 12:58:05 INFO - 'HOME': '/home/cltbld', 12:58:05 INFO - 'LANG': 'en_US.UTF-8', 12:58:05 INFO - 'LANGUAGE': 'en_US:en', 12:58:05 INFO - 'LOGNAME': 'cltbld', 12:58:05 INFO - 'MAIL': '/var/mail/cltbld', 12:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:05 INFO - 'MOZ_NO_REMOTE': '1', 12:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:05 INFO - 'NO_EM_RESTART': '1', 12:58:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:58:05 INFO - 'PWD': '/builds/slave/test-pgo', 12:58:05 INFO - 'SHELL': '/bin/bash', 12:58:05 INFO - 'SHLVL': '1', 12:58:05 INFO - 'TERM': 'linux', 12:58:05 INFO - 'TMOUT': '86400', 12:58:05 INFO - 'USER': 'cltbld', 12:58:05 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', 12:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:05 INFO - '_': '/tools/buildbot/bin/python'} 12:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:05 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:58:05 INFO - Cleaning up... 12:58:05 INFO - Return code: 0 12:58:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f622c66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2453850>, '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 0x23bf330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf7c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', '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:58:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 12:58:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:58:05 INFO - Using env: {'DISPLAY': ':0', 12:58:05 INFO - 'HOME': '/home/cltbld', 12:58:05 INFO - 'LANG': 'en_US.UTF-8', 12:58:05 INFO - 'LANGUAGE': 'en_US:en', 12:58:05 INFO - 'LOGNAME': 'cltbld', 12:58:05 INFO - 'MAIL': '/var/mail/cltbld', 12:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:05 INFO - 'MOZ_NO_REMOTE': '1', 12:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:05 INFO - 'NO_EM_RESTART': '1', 12:58:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:58:05 INFO - 'PWD': '/builds/slave/test-pgo', 12:58:05 INFO - 'SHELL': '/bin/bash', 12:58:05 INFO - 'SHLVL': '1', 12:58:05 INFO - 'TERM': 'linux', 12:58:05 INFO - 'TMOUT': '86400', 12:58:05 INFO - 'USER': 'cltbld', 12:58:05 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', 12:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:05 INFO - '_': '/tools/buildbot/bin/python'} 12:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:05 INFO - Downloading/unpacking psutil>=0.7.1 12:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:58:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:58:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:58:07 INFO - Installing collected packages: psutil 12:58:07 INFO - Running setup.py install for psutil 12:58:07 INFO - building 'psutil._psutil_linux' extension 12:58:07 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:58:07 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:58:07 INFO - building 'psutil._psutil_posix' extension 12:58:07 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:58:08 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:58:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:58:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:58:08 INFO - Successfully installed psutil 12:58:08 INFO - Cleaning up... 12:58:08 INFO - Return code: 0 12:58:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:08 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 0x7f622c66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2453850>, '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 0x23bf330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf7c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', '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:58:08 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:58:08 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:58:08 INFO - Using env: {'DISPLAY': ':0', 12:58:08 INFO - 'HOME': '/home/cltbld', 12:58:08 INFO - 'LANG': 'en_US.UTF-8', 12:58:08 INFO - 'LANGUAGE': 'en_US:en', 12:58:08 INFO - 'LOGNAME': 'cltbld', 12:58:08 INFO - 'MAIL': '/var/mail/cltbld', 12:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:08 INFO - 'MOZ_NO_REMOTE': '1', 12:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:08 INFO - 'NO_EM_RESTART': '1', 12:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:58:08 INFO - 'PWD': '/builds/slave/test-pgo', 12:58:08 INFO - 'SHELL': '/bin/bash', 12:58:08 INFO - 'SHLVL': '1', 12:58:08 INFO - 'TERM': 'linux', 12:58:08 INFO - 'TMOUT': '86400', 12:58:08 INFO - 'USER': 'cltbld', 12:58:08 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', 12:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:08 INFO - '_': '/tools/buildbot/bin/python'} 12:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:58: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:58: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:58: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:58: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:58: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:58: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:58:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:58:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:58:10 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:58:10 INFO - Installing collected packages: mozsystemmonitor 12:58:10 INFO - Running setup.py install for mozsystemmonitor 12:58:10 INFO - Successfully installed mozsystemmonitor 12:58:10 INFO - Cleaning up... 12:58:10 INFO - Return code: 0 12:58:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:10 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f622c66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2453850>, '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 0x23bf330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf7c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', '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:58:10 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 12:58:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:58:10 INFO - Using env: {'DISPLAY': ':0', 12:58:10 INFO - 'HOME': '/home/cltbld', 12:58:10 INFO - 'LANG': 'en_US.UTF-8', 12:58:10 INFO - 'LANGUAGE': 'en_US:en', 12:58:10 INFO - 'LOGNAME': 'cltbld', 12:58:10 INFO - 'MAIL': '/var/mail/cltbld', 12:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:10 INFO - 'MOZ_NO_REMOTE': '1', 12:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:10 INFO - 'NO_EM_RESTART': '1', 12:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:58:10 INFO - 'PWD': '/builds/slave/test-pgo', 12:58:10 INFO - 'SHELL': '/bin/bash', 12:58:10 INFO - 'SHLVL': '1', 12:58:10 INFO - 'TERM': 'linux', 12:58:10 INFO - 'TMOUT': '86400', 12:58:10 INFO - 'USER': 'cltbld', 12:58:10 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', 12:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:10 INFO - '_': '/tools/buildbot/bin/python'} 12:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:10 INFO - Downloading/unpacking blobuploader==1.2.4 12:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:12 INFO - Downloading blobuploader-1.2.4.tar.gz 12:58:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:58:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:58:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:13 INFO - Downloading docopt-0.6.1.tar.gz 12:58:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:58:13 INFO - Installing collected packages: blobuploader, requests, docopt 12:58:13 INFO - Running setup.py install for blobuploader 12:58:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:58:13 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:58:13 INFO - Running setup.py install for requests 12:58:13 INFO - Running setup.py install for docopt 12:58:14 INFO - Successfully installed blobuploader requests docopt 12:58:14 INFO - Cleaning up... 12:58:14 INFO - Return code: 0 12:58:14 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:14 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 0x7f622c66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2453850>, '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 0x23bf330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf7c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', '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:58:14 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:58:14 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:58:14 INFO - Using env: {'DISPLAY': ':0', 12:58:14 INFO - 'HOME': '/home/cltbld', 12:58:14 INFO - 'LANG': 'en_US.UTF-8', 12:58:14 INFO - 'LANGUAGE': 'en_US:en', 12:58:14 INFO - 'LOGNAME': 'cltbld', 12:58:14 INFO - 'MAIL': '/var/mail/cltbld', 12:58:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:14 INFO - 'MOZ_NO_REMOTE': '1', 12:58:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:14 INFO - 'NO_EM_RESTART': '1', 12:58:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:58:14 INFO - 'PWD': '/builds/slave/test-pgo', 12:58:14 INFO - 'SHELL': '/bin/bash', 12:58:14 INFO - 'SHLVL': '1', 12:58:14 INFO - 'TERM': 'linux', 12:58:14 INFO - 'TMOUT': '86400', 12:58:14 INFO - 'USER': 'cltbld', 12:58:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', 12:58:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:14 INFO - '_': '/tools/buildbot/bin/python'} 12:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:58:14 INFO - Running setup.py (path:/tmp/pip-Hb8fZH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:58:14 INFO - Running setup.py (path:/tmp/pip-u3pEVC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:58:14 INFO - Running setup.py (path:/tmp/pip-Hxnr3q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:58:14 INFO - Running setup.py (path:/tmp/pip-whjegd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:58:14 INFO - Running setup.py (path:/tmp/pip-ulL7ih-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:58:14 INFO - Running setup.py (path:/tmp/pip-ZGLQ8L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:58:14 INFO - Running setup.py (path:/tmp/pip-wX8iun-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:58:14 INFO - Running setup.py (path:/tmp/pip-i7gM4H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:58:14 INFO - Running setup.py (path:/tmp/pip-cpZBJl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:58:14 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:58:14 INFO - Running setup.py (path:/tmp/pip-IrP52h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:58:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:58:15 INFO - Running setup.py (path:/tmp/pip-FUKL_x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:58:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:58:15 INFO - Running setup.py (path:/tmp/pip-lGygbA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:58:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:58:15 INFO - Running setup.py (path:/tmp/pip-9mAvBk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:58:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:58:15 INFO - Running setup.py (path:/tmp/pip-7hPFnK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:58:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:58:15 INFO - Running setup.py (path:/tmp/pip-SRKf5_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:58:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:58:15 INFO - Running setup.py (path:/tmp/pip-dDV6k_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:58:15 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:58:15 INFO - Running setup.py (path:/tmp/pip-GA5zJN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:58:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:58:15 INFO - Running setup.py install for manifestparser 12:58:15 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:58:15 INFO - Running setup.py install for mozcrash 12:58:15 INFO - Running setup.py install for mozdebug 12:58:15 INFO - Running setup.py install for mozdevice 12:58:15 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:58:15 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:58:15 INFO - Running setup.py install for mozfile 12:58:16 INFO - Running setup.py install for mozhttpd 12:58:16 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:58:16 INFO - Running setup.py install for mozinfo 12:58:16 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:58:16 INFO - Running setup.py install for mozInstall 12:58:16 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:58:16 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:58:16 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:58:16 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:58:16 INFO - Running setup.py install for mozleak 12:58:16 INFO - Running setup.py install for mozlog 12:58:16 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:58:16 INFO - Running setup.py install for moznetwork 12:58:16 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:58:16 INFO - Running setup.py install for mozprocess 12:58:16 INFO - Running setup.py install for mozprofile 12:58:16 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:58:16 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:58:16 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:58:16 INFO - Running setup.py install for mozrunner 12:58:16 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:58:16 INFO - Running setup.py install for mozscreenshot 12:58:17 INFO - Running setup.py install for moztest 12:58:17 INFO - Running setup.py install for mozversion 12:58:17 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:58:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:58:17 INFO - Cleaning up... 12:58:17 INFO - Return code: 0 12:58:17 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:58: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:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58: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:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:17 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 0x7f622c66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2453850>, '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 0x23bf330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf7c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', '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:58:17 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:58:17 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:58:17 INFO - Using env: {'DISPLAY': ':0', 12:58:17 INFO - 'HOME': '/home/cltbld', 12:58:17 INFO - 'LANG': 'en_US.UTF-8', 12:58:17 INFO - 'LANGUAGE': 'en_US:en', 12:58:17 INFO - 'LOGNAME': 'cltbld', 12:58:17 INFO - 'MAIL': '/var/mail/cltbld', 12:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:17 INFO - 'MOZ_NO_REMOTE': '1', 12:58:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:17 INFO - 'NO_EM_RESTART': '1', 12:58:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:58:17 INFO - 'PWD': '/builds/slave/test-pgo', 12:58:17 INFO - 'SHELL': '/bin/bash', 12:58:17 INFO - 'SHLVL': '1', 12:58:17 INFO - 'TERM': 'linux', 12:58:17 INFO - 'TMOUT': '86400', 12:58:17 INFO - 'USER': 'cltbld', 12:58:17 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', 12:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:17 INFO - '_': '/tools/buildbot/bin/python'} 12:58:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:58:17 INFO - Running setup.py (path:/tmp/pip-ESzBX7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:58:17 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:58:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:58:17 INFO - Running setup.py (path:/tmp/pip-4oPhI1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:58:17 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:58:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:58:17 INFO - Running setup.py (path:/tmp/pip-RWM7mM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:58:17 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:58:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:58:17 INFO - Running setup.py (path:/tmp/pip-w7ZD55-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:58:17 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:58:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:58:17 INFO - Running setup.py (path:/tmp/pip-e47WzK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:58:17 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:58:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:58:17 INFO - Running setup.py (path:/tmp/pip-8uRjjO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:58:17 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:58:17 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:58:17 INFO - Running setup.py (path:/tmp/pip-Gq7588-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:58:18 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:58:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:58:18 INFO - Running setup.py (path:/tmp/pip-muVJLG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:58:18 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:58:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:58:18 INFO - Running setup.py (path:/tmp/pip-PocNbO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:58:18 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:58:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:58:18 INFO - Running setup.py (path:/tmp/pip-4zDEDW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:58:18 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:58:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:58:18 INFO - Running setup.py (path:/tmp/pip-OqHAQR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:58:18 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:58:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:58:18 INFO - Running setup.py (path:/tmp/pip-kwbzNY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:58:18 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:58:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:58:18 INFO - Running setup.py (path:/tmp/pip-NBzong-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:58:18 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:58:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:58:18 INFO - Running setup.py (path:/tmp/pip-0OaCBr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:58:18 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:58:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:58:18 INFO - Running setup.py (path:/tmp/pip-BmUA98-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:58:18 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:58:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:58:18 INFO - Running setup.py (path:/tmp/pip-lqP5DM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:58:18 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:58:18 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:58:18 INFO - Running setup.py (path:/tmp/pip-VVzJTV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:58:18 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:58:18 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:58:18 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:58:18 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:58:18 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:58:18 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:58:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:20 INFO - Downloading blessings-1.6.tar.gz 12:58:20 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:58:20 INFO - Installing collected packages: blessings 12:58:20 INFO - Running setup.py install for blessings 12:58:20 INFO - Successfully installed blessings 12:58:20 INFO - Cleaning up... 12:58:20 INFO - Return code: 0 12:58:20 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:58:20 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:58:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:58:21 INFO - Reading from file tmpfile_stdout 12:58:21 INFO - Current package versions: 12:58:21 INFO - argparse == 1.2.1 12:58:21 INFO - blessings == 1.6 12:58:21 INFO - blobuploader == 1.2.4 12:58:21 INFO - docopt == 0.6.1 12:58:21 INFO - manifestparser == 1.1 12:58:21 INFO - mozInstall == 1.12 12:58:21 INFO - mozcrash == 0.16 12:58:21 INFO - mozdebug == 0.1 12:58:21 INFO - mozdevice == 0.48 12:58:21 INFO - mozfile == 1.2 12:58:21 INFO - mozhttpd == 0.7 12:58:21 INFO - mozinfo == 0.9 12:58:21 INFO - mozleak == 0.1 12:58:21 INFO - mozlog == 3.1 12:58:21 INFO - moznetwork == 0.27 12:58:21 INFO - mozprocess == 0.22 12:58:21 INFO - mozprofile == 0.28 12:58:21 INFO - mozrunner == 6.11 12:58:21 INFO - mozscreenshot == 0.1 12:58:21 INFO - mozsystemmonitor == 0.0 12:58:21 INFO - moztest == 0.7 12:58:21 INFO - mozversion == 1.4 12:58:21 INFO - psutil == 3.1.1 12:58:21 INFO - requests == 1.2.3 12:58:21 INFO - wsgiref == 0.1.2 12:58:21 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:58:21 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:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:21 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:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:21 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 0x7f622c66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2453850>, '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 0x23bf330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf7c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', '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:58:21 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:58:21 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:58:21 INFO - Using env: {'DISPLAY': ':0', 12:58:21 INFO - 'HOME': '/home/cltbld', 12:58:21 INFO - 'LANG': 'en_US.UTF-8', 12:58:21 INFO - 'LANGUAGE': 'en_US:en', 12:58:21 INFO - 'LOGNAME': 'cltbld', 12:58:21 INFO - 'MAIL': '/var/mail/cltbld', 12:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:21 INFO - 'MOZ_NO_REMOTE': '1', 12:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:21 INFO - 'NO_EM_RESTART': '1', 12:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:58:21 INFO - 'PWD': '/builds/slave/test-pgo', 12:58:21 INFO - 'SHELL': '/bin/bash', 12:58:21 INFO - 'SHLVL': '1', 12:58:21 INFO - 'TERM': 'linux', 12:58:21 INFO - 'TMOUT': '86400', 12:58:21 INFO - 'USER': 'cltbld', 12:58:21 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', 12:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:21 INFO - '_': '/tools/buildbot/bin/python'} 12:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:21 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:58:21 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:58:21 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:58:21 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:58:21 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:58:21 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:58:21 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:58:21 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:58:21 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:58:21 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:58:21 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:58:21 INFO - Cleaning up... 12:58:21 INFO - Return code: 0 12:58:21 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:58:21 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:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:21 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:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:21 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 0x7f622c66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2453850>, '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 0x23bf330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf7c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', '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:58:21 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:58:21 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:58:21 INFO - Using env: {'DISPLAY': ':0', 12:58:21 INFO - 'HOME': '/home/cltbld', 12:58:21 INFO - 'LANG': 'en_US.UTF-8', 12:58:21 INFO - 'LANGUAGE': 'en_US:en', 12:58:21 INFO - 'LOGNAME': 'cltbld', 12:58:21 INFO - 'MAIL': '/var/mail/cltbld', 12:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:21 INFO - 'MOZ_NO_REMOTE': '1', 12:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:21 INFO - 'NO_EM_RESTART': '1', 12:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:58:21 INFO - 'PWD': '/builds/slave/test-pgo', 12:58:21 INFO - 'SHELL': '/bin/bash', 12:58:21 INFO - 'SHLVL': '1', 12:58:21 INFO - 'TERM': 'linux', 12:58:21 INFO - 'TMOUT': '86400', 12:58:21 INFO - 'USER': 'cltbld', 12:58:21 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', 12:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:21 INFO - '_': '/tools/buildbot/bin/python'} 12:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:21 INFO - Downloading/unpacking jsonschema 12:58: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:58: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:58: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:58: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:58: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:58: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:58:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:58:23 INFO - Downloading/unpacking functools32 (from jsonschema) 12:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:23 INFO - Downloading functools32-3.2.3-2.tar.gz 12:58:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:58:23 INFO - warning: no files found matching '*.txt' 12:58:23 INFO - no previously-included directories found matching 'build' 12:58:23 INFO - no previously-included directories found matching 'dist' 12:58:23 INFO - no previously-included directories found matching '.git*' 12:58:23 INFO - Installing collected packages: jsonschema, functools32 12:58:23 INFO - Running setup.py install for functools32 12:58:23 INFO - warning: no files found matching '*.txt' 12:58:23 INFO - no previously-included directories found matching 'build' 12:58:23 INFO - no previously-included directories found matching 'dist' 12:58:23 INFO - no previously-included directories found matching '.git*' 12:58:23 INFO - Successfully installed jsonschema functools32 12:58:23 INFO - Cleaning up... 12:58:23 INFO - Return code: 0 12:58:23 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f622c66cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23c1290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2453850>, '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 0x23bf330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf7c0>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', '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:58:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 12:58:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:58:23 INFO - Using env: {'DISPLAY': ':0', 12:58:23 INFO - 'HOME': '/home/cltbld', 12:58:23 INFO - 'LANG': 'en_US.UTF-8', 12:58:23 INFO - 'LANGUAGE': 'en_US:en', 12:58:23 INFO - 'LOGNAME': 'cltbld', 12:58:23 INFO - 'MAIL': '/var/mail/cltbld', 12:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:23 INFO - 'MOZ_NO_REMOTE': '1', 12:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:23 INFO - 'NO_EM_RESTART': '1', 12:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:58:23 INFO - 'PWD': '/builds/slave/test-pgo', 12:58:23 INFO - 'SHELL': '/bin/bash', 12:58:23 INFO - 'SHLVL': '1', 12:58:23 INFO - 'TERM': 'linux', 12:58:23 INFO - 'TMOUT': '86400', 12:58:23 INFO - 'USER': 'cltbld', 12:58:23 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', 12:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:23 INFO - '_': '/tools/buildbot/bin/python'} 12:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:24 INFO - Downloading/unpacking flake8 12:58:24 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:58:24 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:58:24 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:58:24 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:58:24 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:58:24 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:58:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:58:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:58:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:58:26 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:58:26 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:58:26 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:58:26 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:58:26 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:58:26 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:58:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:58:26 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:58:26 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:58:26 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:58:26 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:58:26 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:58:26 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:58:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:58:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:58:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:58:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:58:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:58:26 INFO - no previously-included directories found matching 'docs/_build' 12:58:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:58:26 INFO - Running setup.py install for pep8 12:58:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:58:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:58:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:58:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:58:26 INFO - no previously-included directories found matching 'docs/_build' 12:58:26 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:58:26 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:58:26 INFO - Cleaning up... 12:58:26 INFO - Return code: 0 12:58:26 INFO - Running post-action listener: _resource_record_post_action 12:58:26 INFO - Running post-action listener: _start_resource_monitoring 12:58:26 INFO - Starting resource monitoring. 12:58:26 INFO - ##### 12:58:26 INFO - ##### Running install step. 12:58:26 INFO - ##### 12:58:26 INFO - Running pre-action listener: _resource_record_pre_action 12:58:26 INFO - Running main action method: install 12:58:26 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:58:26 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:58:27 INFO - Reading from file tmpfile_stdout 12:58:27 INFO - Detecting whether we're running mozinstall >=1.0... 12:58:27 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:58:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:58:27 INFO - Reading from file tmpfile_stdout 12:58:27 INFO - Output received: 12:58:27 INFO - Usage: mozinstall [options] installer 12:58:27 INFO - Options: 12:58:27 INFO - -h, --help show this help message and exit 12:58:27 INFO - -d DEST, --destination=DEST 12:58:27 INFO - Directory to install application into. [default: 12:58:27 INFO - "/builds/slave/test-pgo"] 12:58:27 INFO - --app=APP Application being installed. [default: firefox] 12:58:27 INFO - mkdir: /builds/slave/test-pgo/build/application 12:58:27 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:58:27 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:58:39 INFO - Reading from file tmpfile_stdout 12:58:39 INFO - Output received: 12:58:39 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:58:39 INFO - Running post-action listener: _resource_record_post_action 12:58:39 INFO - ##### 12:58:39 INFO - ##### Running run-tests step. 12:58:39 INFO - ##### 12:58:39 INFO - Running pre-action listener: _resource_record_pre_action 12:58:39 INFO - Running main action method: run_tests 12:58:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:58:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:58:39 INFO - Python 2.7.3 12:58:39 INFO - Return code: 0 12:58:39 INFO - grabbing minidump binary from tooltool 12:58:39 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:58:39 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 0x2453850>, '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 0x23bf330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23bf7c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:58:39 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:58:39 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:58:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:58:39 INFO - Return code: 0 12:58:39 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:58:39 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:58:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:58:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:58:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:58:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:58:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:58:40 INFO - Return code: 0 12:58:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 12:58:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 12:58:40 INFO - Using env: {'DISPLAY': ':0', 12:58:40 INFO - 'HOME': '/home/cltbld', 12:58:40 INFO - 'LANG': 'en_US.UTF-8', 12:58:40 INFO - 'LANGUAGE': 'en_US:en', 12:58:40 INFO - 'LOGNAME': 'cltbld', 12:58:40 INFO - 'MAIL': '/var/mail/cltbld', 12:58:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:58:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:40 INFO - 'MOZ_NO_REMOTE': '1', 12:58:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:58:40 INFO - 'NO_EM_RESTART': '1', 12:58:40 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:58:40 INFO - 'PWD': '/builds/slave/test-pgo', 12:58:40 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:58:40 INFO - 'SHELL': '/bin/bash', 12:58:40 INFO - 'SHLVL': '1', 12:58:40 INFO - 'TERM': 'linux', 12:58:40 INFO - 'TMOUT': '86400', 12:58:40 INFO - 'USER': 'cltbld', 12:58:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826', 12:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:40 INFO - '_': '/tools/buildbot/bin/python'} 12:58:40 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:58:41 INFO - mozversion application_buildid: 20160315101834 12:58:41 INFO - mozversion application_changeset: 59d1a8971a8ca27376bde5d16fc76b4cbb39da7c 12:58:41 INFO - mozversion application_display_name: Firefox 12:58:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:58:41 INFO - mozversion application_name: Firefox 12:58:41 INFO - mozversion application_remotingname: firefox 12:58:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:58:41 INFO - mozversion application_vendor: Mozilla 12:58:41 INFO - mozversion application_version: 46.0 12:58:41 INFO - mozversion platform_buildid: 20160315101834 12:58:41 INFO - mozversion platform_changeset: 59d1a8971a8ca27376bde5d16fc76b4cbb39da7c 12:58:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:58:41 INFO - mozversion platform_version: 46.0 12:58:41 INFO - using testdate: 1458071921 12:58:41 INFO - actual date: 1458071921 12:58:41 INFO - starting webserver on 'localhost:35032' 12:58:41 INFO - SUITE-START | Running 3 tests 12:58:41 INFO - TEST-START | dromaeo_css 12:58:41 INFO - operating with platform_type : linux_ 12:58:41 INFO - Initialising browser for dromaeo_css test... 12:58:41 INFO - TEST-INFO | started process 28080 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp57Glfw/profile http://localhost:35032/getInfo.html) 12:58:45 INFO - PROCESS | 28080 | __metrics Screen width/height:1600/1200 12:58:45 INFO - PROCESS | 28080 | colorDepth:24 12:58:45 INFO - PROCESS | 28080 | Browser inner width/height: 1024/697 12:58:45 INFO - PROCESS | 28080 | __metrics 12:58:45 INFO - PROCESS | 28080 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:58:46 INFO - TEST-INFO | 28080: exit 0 12:58:46 INFO - Browser initialized. 12:58:46 INFO - Running cycle 1/1 for dromaeo_css test... 12:58:46 INFO - TEST-INFO | started process 28170 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp57Glfw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:58:58 INFO - PROCESS | 28170 | RSS: Main: 136716288 12:58:58 INFO - PROCESS | 28170 | 12:59:49 INFO - PROCESS | 28170 | 1458071989160 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:01:56 INFO - PROCESS | 28170 | Cycle 1(1): loaded http://localhost:35032/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35032/tests/dromaeo/cssquery-ext.html) 13:01:57 INFO - PROCESS | 28170 | RSS: Main: 241242112 13:01:57 INFO - PROCESS | 28170 | 13:05:00 INFO - PROCESS | 28170 | Cycle 1(1): loaded http://localhost:35032/tests/dromaeo/cssquery-ext.html (next: http://localhost:35032/tests/dromaeo/cssquery-jquery.html) 13:05:00 INFO - PROCESS | 28170 | RSS: Main: 217714688 13:05:00 INFO - PROCESS | 28170 | 13:08:02 INFO - PROCESS | 28170 | Cycle 1(1): loaded http://localhost:35032/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35032/tests/dromaeo/cssquery-mootools.html) 13:08:03 INFO - PROCESS | 28170 | RSS: Main: 230719488 13:08:03 INFO - PROCESS | 28170 | 13:11:04 INFO - PROCESS | 28170 | Cycle 1(1): loaded http://localhost:35032/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35032/tests/dromaeo/cssquery-prototype.html) 13:11:05 INFO - PROCESS | 28170 | RSS: Main: 204083200 13:11:05 INFO - PROCESS | 28170 | 13:14:07 INFO - PROCESS | 28170 | Cycle 1(1): loaded http://localhost:35032/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35032/tests/dromaeo/cssquery-yui.html) 13:14:08 INFO - PROCESS | 28170 | RSS: Main: 205021184 13:14:08 INFO - PROCESS | 28170 | 13:17:10 INFO - PROCESS | 28170 | Cycle 1(1): loaded http://localhost:35032/tests/dromaeo/cssquery-yui.html (next: http://localhost:35032/tests/dromaeo/cssquery-dojo.html) 13:17:11 INFO - PROCESS | 28170 | RSS: Main: 250638336 13:17:11 INFO - PROCESS | 28170 | 13:17:11 INFO - PROCESS | 28170 | __start_tp_report 13:17:11 INFO - PROCESS | 28170 | _x_x_mozilla_page_load 13:17:11 INFO - PROCESS | 28170 | _x_x_mozilla_page_load_details 13:17:11 INFO - PROCESS | 28170 | |i|pagename|runs| 13:17:11 INFO - PROCESS | 28170 | |0;dojo.html;3161.225499752561;3244.9675503244976;3246.5130230465443;3257.1694217974414;3292.8682852685893;5211;5225.137852254383;5229.8169564065265;5234.685918844872;5237.10969135247;5230.2416149658275;5237.266782650432;5247.370315562129;5253.949210157964;5297.178937264721;4703.059388122372;4776.665633405663;4801.351817504627;4832.767644250729;4875.63432742544;4736.573708366246;4743.241081426972;4785.71285722856;4808.134535783557;4821.951780482203;4792.281157826319;4820.493848145947;4843.370361852954;4856.4172299323955;4876.122297986361;4718.457377401608;4768.451628062782;4815.927761083586;4837.492063333352;4838.733869637169;4718.05638872227;4748.715077095385;4775.307580400857;4785.928211076836;4806.663533552653;5021.824236151717;5024.321716568253;5028.874278143076;5048.368953880765;5050.898982020376;5449.7275136243425;5532.446755324436;5544.085225937715;5549.861253468655;5561.944380556183;5602.7758889644365;5640.041192997201;5659.037963546207;5670.801521946753;5703;5239.476052394768;5267.47325267474;5271.472852714698;5272.31459910213;5278.683279003272;5528.75120619565;5623.8875222496135;5680.204771332017;5731.254936858182;5744.396838331999;5537.446255374511;5542.8337149885565;5547.861303467445;5551.3893471718075;5553.0004599172535;5564.1931919871395;5606.355269144019;5610.607257492018;5614.242077319591;5620.91568626471;5457.154141108134;5544.362398324163;5546.140348246028;5581.246531718247;5612.466815652507;5602.691851948182;5611.579131565068;5618.4662457066515;5618.831435056954;5620.466055724782;4305.913881722348;4320.395144679747;4337.024169561886;4347.478302603708;4368.08270263242;3858.5176852893387;3889.5527014393706;3928.233994371127;3943.2310699413338;3947.111899822517;5244.659097158673;5250.842474725764;5266.3943646480375;5267.525922666979;5283.550898173621;5550.306211723535;5553.750081246354;5562.9443705563235;5568.721563921868;5574.9721251393485;5102.69383836971;5221.556167725786;5242.318498595158;5295.470452954751;5327.81352652663;4842.467328593852;4860.125177468019;4877.073356062337;4889.2910527973245;4920.876978075506;5661.348944871393;5766.509846662997;5767.826965191051;5774.133879917962;5784.797532086441;5502.697351645698;5573.832785016456;5648.774049037993;5690.146478028329;5709.628874123168;5720.941625799241;5764.164196191613;5770.567207459373;5773.336066352424;5774.82675519735;5377.489138531833;5512.4211957743855;5541.889162216814;5552.7778888843995;5576.470235327637;5651.350094739158;5710.400407957105;5717.42825717425;5729;5734.541236701138;5361.946380536145;5364.678119312854;5372.1404575269335;5384.919226211531;5397.703126327932;5389.676619402849;5410.756515956713;5442.5645948323245;5447.155690867922;5503.807366742145;5358.169483730028;5363.27595774581;5385.54222891043;5388.057090009154;5397.595180361567;5478.205660179331;5538.252335934597;5540.445955404427;5551.417101204477;5574.247476590771;5320.627556071038;5363.946360536344;5410.48600382963;5425.321834770653;5466.863328416822 13:17:11 INFO - PROCESS | 28170 | |1;ext.html;559.7453158812738;574.482965331202;581.4476247564814;588.2411688921292;596.1981135372923;31464.213394665116;38721.80639096804;39053;39104.60895391049;39179;47007.764961175235;47841.76079119599;48030.27954580684;48075.75962120185;48095.759521202344;9076.8638470423;9231.169194772468;9284.953575232114;9290.163885250326;9292.210162136227;9024.503652299121;9170.587323570422;9185.357025008252;9195.586198621078;9207.079292070774;9196.126367995063;9231.215346695539;9308.488033158173;9308.8603670945;9313.068693130666;9132;9152.405093668891;9213.769655758593;9234.630614775435;9237.399569028059;8977.551122443918;9155.221806146486;9157.862632060524;9158.542072896329;9161.908380916238;43024.56975430268;43352.13295734099;43458.565414345765;43508.782456087836;43535.564644353464;3627.220147668264;3862.0731024554184;4040.656544193747;4146.979265103685;4222.577742225752;32282.838585807156;32589.185270368194;32798.3440331192;33050;33282.535207072535;4186.602272784081;4216.241076606209;4223.704340696153;4281.828726850922;4296.978515107405;275743;276205;277552;278919;279400;59079.40920590825;59223.70388148118;64309.356906431276;64750;66315;60960.69519652462;61059;61443.6927815367;61465.69267153636;61483.69258153681;18286.63426731458;18484.72272915907;18509.907450462662;18527.351542695942;18528.44414667562;13617.591472255848;13631.727365452636;13667.794983075262;13700;13713.794293085612;21385.465363366042;22271.665925011137;22424.55150896973;22437.21469748551;22525.4368640782;8083.100471389219;8361.247487726134;8363.623636936352;8364.205400486944;8366.45618034838;1062.3041907550567;1138.9430528473708;1139.333489908413;1146.2893006336126;1150.551284998851;30793.230169245948;30870.69129308678;31025.224369390944;31098.067057987842;32144;1156.6819124740764;1168.696139003865;1193.665773583398;1206.3003457994341;1251.455616806692;14052;15408.922955385151;15832.92083539598;16093.436729714638;16228.107454090139;180278;181108;181173;181270;182082;49172.508274917505;49842;56990.43009569851;57260.71369643125;57434;1471.8380978092616;1472.0578829549097;1480.3782411387244;1514.7349213887526;1602.0227661126703;28347.85826070939;30268.727040408598;30575.694243057285;30877.536836947016;30951.535726964565;45345.31982020338;47661.28508072451;48462.75768621134;52136;53060.4693953071;373550;380022;380151;381467;383421;46767.29849052335;46895.531044690484;47341;47699;48280;50762;50821;50844.49155508397;51522.48477515177;52031;41723;42274.15451690887;42880.57119428766;43375.566244337155;44429.111417770815;42020.369694454;42612.786936065124;42686.5731342695;43309;43515.78242108896;40864;41217.58782412137;41797.582024180585;41819;41863;36624.81687591651;36904.29517877883;37513.2497350046;38523.80738096291;38971.6102838968;25874.48251034931;26200.475990479703;26275.73724262733;26638.200853974413;26767.598486023115 13:17:11 INFO - PROCESS | 28170 | |2;jquery.html;385.3853104298644;388.1770646229993;389.2642904909721;392.5485691454828;392.605431541301;14680.119192848437;14919.731822795075;16703.58241043973;18438.631227375463;18449;17889.463316100537;18373.54066148347;18428;18567.164477598508;18870.056497175156;6030.969845150768;6250.000000000001;6273.153124328226;6278.529110316722;6305.180326557564;4609.308603709454;4716.716996980175;4756.120117778205;6158.291796443422;6221.564490485668;5496.780128794843;5686.232358631594;7062.293770622922;7065;7078.716851325967;5562.7774889004395;5596.496315331639;5597.384287728347;5604;5605.467480589337;5335.919961200585;5603;5623.8594035149445;5625.634333768333;5632.295963004624;13631.386587603582;15338.846611533854;20917.47706307339;21533.892330538405;21541.78458215429;2178.498945242603;2227.509947811479;2243.5064285857084;2319.8028167605776;2355.97644023561;9865.704028879145;10007.249456290807;10236.74408139795;10976.341419514854;13320.800187997187;1857.7399164117035;1919.0117089698817;1952;1969.7636283646054;1976.24902537035;59437.40562594362;60479.69760151215;61334.38665613376;62691.686541567;63268;10895.07391871684;11010.834837477445;11011.174161937726;11106.833397499044;11128.276662016942;14328.49850255236;14514.637134071732;14542.418303267963;14555.636109097146;14575.708485830224;8419.747407577783;8453.95773021131;8509.361797865186;8572.828543429096;8627.654893804303;8095.676172953134;8127.634256458474;8174.632141553644;8180.304674102649;8284;4361.716488428242;4530.637548996138;4699.506551812011;4790.185668436374;4831.130396528659;1881.9717704234447;1914.2821441959265;1928.7781905080815;1937.1573365586016;1956.0610906764548;1002.7192386131894;1034.4775888176423;1059.9470026498643;1085.7719878825535;1097.2977294531506;15160.545183644508;17096.145192740314;17158.227879745442;17655.293788248327;17700.822991770176;955.398099197515;1018.2108865629049;1022.6676330192569;1030.8041472120274;1072.5977758340623;8832;9197.711706718392;9265.119813617695;9325.114114159143;9436.528173591292;500227;501075;535753;581546;585478;47878;48273.5172648269;51431.97136057258;74275.62862185763;77247.61376193083;1215.7143071378218;1225.96935076622;1227.7053507158396;1229.624964385853;1236.758832027746;14216.502422415166;14677.779833302722;14677.972541921963;14832.62918427048;15846;31380;34430.48354274638;35812.28375432425;36588.81705591455;37258.62741372552;49178;49533.75233123956;50174;50516.74741626268;52919.94160116853;10408.895911040792;10614.310069845435;10879.564817407532;10904;11083.390413527011;10335.896641033494;11853.34806585646;12173.147879648339;12200.75598488043;12419.254844709347;3097.5818264534;4654.58035299237;6020.698965051817;10924.453777310944;11134.634204797328;11337.943310283395;11435.771284574095;11452.541898323974;11515.25150865191;11617.593384231512;7867.567283799217;8177.79555511117;8179;8312.08567057611;11590.304581725124;8203.42576019673;10758.784824303313;10901.781964360509;11045.447727613748;11049.834252486058;10478.842817357594;10795.40625265618;10905.563777448813;11042.668719938414;11185.888141118485 13:17:11 INFO - PROCESS | 28170 | |3;mootools.html;1424.9572512824618;1550.3798480607757;1556.0974634711865;1769.4249368955093;1881.8024107468716;7346.338829505344;7540.321371076602;7795.883061754071;7979.92020079799;8022.91977080229;7895.0920644125945;7896.368290536758;7993.560354180518;7998.1601931797195;8006.439549231556;2370.0519792083132;2406.181898154627;2407.963880541793;2409.3013026222375;2411.807055435561;2376.5484557934024;2395.0419832067137;2410.4214988402746;2411.9397015074587;2413.4328432818274;2344.5779759643256;2359.1389142962867;2361.138184562631;2396.8681722505257;2400.3039118655656;2351.9176828810996;2360.079568968104;2366.5030343627773;2368.751281115484;2420.854748715065;2423.5395274897714;2433.051110067075;2433.7322894481595;2443.132687895807;2448.8408253463645;8067.031956165239;8090.069641991128;8117.512949223065;8122.553259570721;8124.146964568753;4913.950860491421;5046.369203849519;5054.974725126388;5059.241113832918;5061.038402703512;3066;3088.382323535302;3126.296583268769;3135.2475405902646;3156.794808337451;1178.8054970929786;2005.2780998840406;2005.5988802239465;2005.81947624713;2049.1803278688494;11273.492692828842;11433.428328583537;11437.256578322465;11467.254628449124;11497.54009839597;4387.232234358974;4389.122175564899;4460.085682435093;4575.565321294538;4576.679632425698;9926.702198934043;9979.750506237257;9985.400875947467;9990.550425230882;10003.79992400148;5064.670796398223;5095.337606111182;5098.337216161949;5103.030424219386;5107.795688172431;4040.91918161641;4082.1427500225286;4368.694191406571;4425.336199570091;4612.884677883013;3823.9235215296094;3840.347140986039;3860.0735823402183;3897.1815918656835;3904.04350934023;1166.4692564882957;1193.5822462138183;1200.4477940147456;1205.3069485046133;1214.4292182674128;1373.8763511283832;1382.4539306973688;1394.1286695815115;1408.6126315263384;1409.7955796409462;7579.090509138939;7786.104597971193;7790.182030886675;7865.488743231672;7928.643211055401;516.7752027867889;520.7005971566365;521.7495602111007;527.0644605824692;528.4715284715285;6207.286162091417;6216.067589861466;6296.118543403927;6298.118263443122;6301.117843501914;9366.250699943988;9719.125278724949;9729.075737804897;9737.853932191023;9749.756256093513;9303.395279306824;9575.329726919188;9642.662506812228;9659.178969787647;9663.420194788336;7583.544987300779;7593.468457208053;7650.846983060196;7653.655585498666;7663.770086897402;7157.069580954442;7172.462065345016;7176.497645164788;7184;7461.141968673672;8542.572871356282;8655.394122411371;8770.12298770118;8885.555722213992;8922.68770593026;8806.779830504289;9089;9106.863397048917;9124.680636177702;9218.44689318643;6293.622382657055;6387.265464471645;6397.328280530477;7131.607761573163;7163.7492687755675;7549.433792465477;7714.305712485903;7732.7680169595005;7739.032620922385;7741.651625676971;7021;7111.146662400338;7228.241034691282;7291.8541629168185;7378.926210737824;7127.572345659277;7163.713451462092;7184.928150718635;7210;7270.345668889825;7162.606056666933;7433.1823499416105;7446.92553074484;7471.439642026761;7524.736634217995;6767;6795.592264464148;6815.693293801692;6826.590404575742;6828.146481689789;6939.236683964861;6989.161300643956;6989.196242431982;6989.650517474004;7086.468514861509 13:17:11 INFO - PROCESS | 28170 | |4;prototype.html;372.0791042170628;373.240455672706;373.91213064929735;374.40282749015313;381.692737346436;5983.252093488314;6012.458878700922;6022.789202377918;6039.275286965571;6065.059915713061;5678.858028549278;5756.366799652035;5793.6234144780665;5925.940740592593;5951.851203719909;4669.813207471697;4672.135654903836;4685.109829132471;4694.08465349257;4699.577038066574;4506.864794056167;4689.179393606122;4708.152532544141;4709.717416954976;4715.056988602293;4548.044910568785;4563.703359281636;4638.0491999140095;4657.813687452498;4691.413573303337;4631.976840115812;4646.070785842828;4649.744264065475;4654.185517534418;4674.158651442739;4159.750414975111;4166.729162604452;4172.833086676529;4179.2895207814745;4182.100848317596;5559.221708960748;5724.198612194296;5726.3700992890745;5729.140628905656;5730.140478928152;5361.758720857531;5362.946370536284;5367.812126575551;5368.91946620801;5416.160495123262;6379.649119298437;6393.584417012926;6396.584222025554;6402.13571167891;6405.295417504118;4536.432945881765;4545.727256364596;4546.636269098464;4548.95451045492;4551.067031258584;6447.6131432114225;6543.93456065438;6618.271990081087;6626.503012274099;6627.867442651168;4656.161890859677;4659.603933665609;4662.137504561667;4663.160631086437;4665.6734028617675;4721.126591580569;4722.645801564828;4725.692829966041;4726.26742854858;4726.71639701619;5371.328583927009;5372.650777699437;5375.3012108425655;5380.865478362994;5381.13901775714;6233.501319894398;6332.366763323631;6386.393292637192;6388.904166437507;6399.360063993563;1638.262781748218;1652.0583267537388;1653.5783375239478;1655.2551351891698;1657.4696097248764;1119.485036883043;1123.4888125902694;1124.746931940307;1140.5950887434842;1145.7479354541988;6156;6168.444839964424;6169.413905678954;6173.104899789505;6176.505879529627;6374.776882809079;6572.375624315682;6582.275949645536;6582.407583317525;6588.143541339595;6041.486473649701;6093.299270583851;6230.43926046658;6242.531810114168;6249.687515624291;3522.8238588070494;3602.567691876939;3604.0809593553477;3605.369060414417;3605.4231322988194;6741.426978706865;6795.2185498667295;6832.6925288362145;6913.89629155563;6914.757983470555;6783.18601767791;6800.149981252343;6800.52396332252;6804.863902722017;6805.149356330458;6796.116504854337;6816.250212476623;6819;6825.453963682993;6825.55633883796;6540.321059476553;6562.868742625216;6582.979638156094;6619.702113404812;6633.834154146185;6491.350864913471;6503.804885853432;6518.478521718156;6521.445677117498;6531.412172904462;6805.829854253683;6828.385445309946;6830.112085428863;6832.214295355899;6835.658217089225;4679.953200467951;4679.976600116977;4682.2508398656055;4685.367475390779;4686.953130468652;6429.324920883427;6510.381513756186;6568.507361947777;6588.275289718223;6598.911179655303;6401.551891367746;6410.775622853178;6413.262474815269;6413.967930160319;6418.518611104279;6341.619502829845;6400.39196276353;6404.9039264412;6410.711517981609;6412.807615771534;6279.874402512016;6300.464460520907;6306.684665766602;6307.96846015767;6314.810555683337;6490.350964903472;6492.545521813617;6495.480361570969;6496.187976502937;6502.252240992347;6161.661108638888;6349.7142628580905;6351.396617321347;6357.332480089709;6358.0780786784735 13:17:11 INFO - PROCESS | 28170 | |5;yui.html;777.0403551613758;806.1897792718318;858.1804376820137;880.1506546182932;961.0581630002597;13275;13344.93327533361;13403.262820544865;13426.597202083942;13580.660483487918;12997.675058123552;13232.93383533081;13272.004599655016;13281.269530175836;13288.800667989988;764.858501177284;771.533222400448;893.8793262909521;902.855543113102;912.0195789526252;902.9367944243905;905.4974489158515;909.9727008189765;911.3893691226893;913.6756451459736;954.0697819625844;955.9091886270828;956.2015716876382;956.5743244256308;956.689076050283;779.555653277632;780.0717146595562;938.7277689470011;940.1632547033146;952.4333021851987;699.9720011199546;702.7680865314434;703.496999645251;705.8023753349071;707.1973310292803;14624.488142915054;14654.633634159125;14677.412903483848;14678.266086695623;14717;13380.264085475295;13805;13833.584992450242;13916.58250252494;13990.930045349709;11071.667849964433;11117.72205694856;11118.054965327958;11305.378204198765;11310.886891131147;3669.933782706241;3723.5345581802276;3753.8498460061564;3766.679832214265;3794.335991201556;49010;52774;52794.20808687873;53009.46990530084;53027.73486132583;10907.672769816918;10989.780204395867;11169.38568378747;11281.266717663326;11315.547378104948;19734.901325493567;20035.799642003683;20055.29806456767;20055.398338049883;20140.798592013893;7551.320381165721;7865.370770338359;7923.762287131395;7959.164287749819;8159.061707903667;4150.418941348214;4235.97882010588;4304.677149213821;4343.804528796211;4355.216061108968;3143.449896268144;3155.1796532901612;3177.3168768714836;3191.457452233126;3195.3130077033547;569.5159114752428;581.5667327840786;584.7690162385834;588.6497533967282;593.9813220327073;603.5895590998076;671.5198632977445;672.707372293054;705.6295444891473;714.17156098925;9049.954750226207;9665;9837.9016209837;9838.508074596384;9875.703728888146;543.6547792151933;558.0262442038587;574.9425057494217;688.8002479281053;694.2398074108843;4402.603765661106;4414.205443020223;4449.2658711312915;4532.093581283756;4584.701994370422;56468.152977705366;56725.43274567201;56984;57154.7142264286;62574.37425625777;50812.23781643278;51164;51466.48533514617;52021.7398913003;52797.7360113197;45250.321245181345;45464.54535454603;45601.77199113983;47333;47840.76079619649;9037.322200835095;9135.086491351078;9255.398399104037;9267.953660231655;9306.441613503212;35170;35717.642823571434;37254.44118338173;37287.6271237295;37570.43644345392;45646.31530526978;45783;45836.54163458456;46160;47433.52566474291;11870.940645296718;12141.210821296587;12170.57402990891;12269.447874845475;12347.19743216688;13076.215427074407;13274.668133296746;13494.595162145151;13501.459941602227;13506.729865402833;11431.942840285745;11544.134189935621;11685.240459370114;11855.881441185478;12132.332721700392;11536.307821530734;11697.590584329508;11799.764004719686;11854.348010859485;12127.272363658209;10839.651222567994;11278.661640150809;11319.603813866805;11800.82298765502;12574.811377829157;9763.658271960447;9904.653337133166;10149.13442082392;10293.125084367613;10342.069213770797;10297;10316.587336506456;10478.604977810735;10638.8404173939;10709.839352409565 13:17:11 INFO - PROCESS | 28170 | __end_tp_report 13:17:11 INFO - PROCESS | 28170 | __start_cc_report 13:17:11 INFO - PROCESS | 28170 | _x_x_mozilla_cycle_collect,787 13:17:11 INFO - PROCESS | 28170 | __end_cc_report 13:17:11 INFO - PROCESS | 28170 | __startTimestamp1458073031035__endTimestamp 13:17:11 INFO - PROCESS | 28170 | 13:17:11 INFO - PROCESS | 28170 | ------- Summary: start ------- 13:17:11 INFO - PROCESS | 28170 | Number of tests: 6 13:17:11 INFO - PROCESS | 28170 | 13:17:11 INFO - PROCESS | 28170 | [#0] dojo.html Cycles:165 Average:5207.01 Median:5377.49 stddev:549.91 (10.2%) stddev-sans-first:527.65 13:17:11 INFO - PROCESS | 28170 | Values: 3161.2 3245.0 3246.5 3257.2 3292.9 5211.0 5225.1 5229.8 5234.7 5237.1 5230.2 5237.3 5247.4 5253.9 5297.2 4703.1 4776.7 4801.4 4832.8 4875.6 4736.6 4743.2 4785.7 4808.1 4822.0 4792.3 4820.5 4843.4 4856.4 4876.1 4718.5 4768.5 4815.9 4837.5 4838.7 4718.1 4748.7 4775.3 4785.9 4806.7 5021.8 5024.3 5028.9 5048.4 5050.9 5449.7 5532.4 5544.1 5549.9 5561.9 5602.8 5640.0 5659.0 5670.8 5703.0 5239.5 5267.5 5271.5 5272.3 5278.7 5528.8 5623.9 5680.2 5731.3 5744.4 5537.4 5542.8 5547.9 5551.4 5553.0 5564.2 5606.4 5610.6 5614.2 5620.9 5457.2 5544.4 5546.1 5581.2 5612.5 5602.7 5611.6 5618.5 5618.8 5620.5 4305.9 4320.4 4337.0 4347.5 4368.1 3858.5 3889.6 3928.2 3943.2 3947.1 5244.7 5250.8 5266.4 5267.5 5283.6 5550.3 5553.8 5562.9 5568.7 5575.0 5102.7 5221.6 5242.3 5295.5 5327.8 4842.5 4860.1 4877.1 4889.3 4920.9 5661.3 5766.5 5767.8 5774.1 5784.8 5502.7 5573.8 5648.8 5690.1 5709.6 5720.9 5764.2 5770.6 5773.3 5774.8 5377.5 5512.4 5541.9 5552.8 5576.5 5651.4 5710.4 5717.4 5729.0 5734.5 5361.9 5364.7 5372.1 5384.9 5397.7 5389.7 5410.8 5442.6 5447.2 5503.8 5358.2 5363.3 5385.5 5388.1 5397.6 5478.2 5538.3 5540.4 5551.4 5574.2 5320.6 5363.9 5410.5 5425.3 5466.9 13:17:11 INFO - PROCESS | 28170 | 13:17:11 INFO - PROCESS | 28170 | [#1] ext.html Cycles:180 Average:47654.31 Median:41941.68 stddev:76247.92 (181.8%) stddev-sans-first:76379.82 13:17:11 INFO - PROCESS | 28170 | Values: 559.7 574.5 581.4 588.2 596.2 31464.2 38721.8 39053.0 39104.6 39179.0 47007.8 47841.8 48030.3 48075.8 48095.8 9076.9 9231.2 9285.0 9290.2 9292.2 9024.5 9170.6 9185.4 9195.6 9207.1 9196.1 9231.2 9308.5 9308.9 9313.1 9132.0 9152.4 9213.8 9234.6 9237.4 8977.6 9155.2 9157.9 9158.5 9161.9 43024.6 43352.1 43458.6 43508.8 43535.6 3627.2 3862.1 4040.7 4147.0 4222.6 32282.8 32589.2 32798.3 33050.0 33282.5 4186.6 4216.2 4223.7 4281.8 4297.0 275743.0 276205.0 277552.0 278919.0 279400.0 59079.4 59223.7 64309.4 64750.0 66315.0 60960.7 61059.0 61443.7 61465.7 61483.7 18286.6 18484.7 18509.9 18527.4 18528.4 13617.6 13631.7 13667.8 13700.0 13713.8 21385.5 22271.7 22424.6 22437.2 22525.4 8083.1 8361.2 8363.6 8364.2 8366.5 1062.3 1138.9 1139.3 1146.3 1150.6 30793.2 30870.7 31025.2 31098.1 32144.0 1156.7 1168.7 1193.7 1206.3 1251.5 14052.0 15408.9 15832.9 16093.4 16228.1 180278.0 181108.0 181173.0 181270.0 182082.0 49172.5 49842.0 56990.4 57260.7 57434.0 1471.8 1472.1 1480.4 1514.7 1602.0 28347.9 30268.7 30575.7 30877.5 30951.5 45345.3 47661.3 48462.8 52136.0 53060.5 373550.0 380022.0 380151.0 381467.0 383421.0 46767.3 46895.5 47341.0 47699.0 48280.0 50762.0 50821.0 50844.5 51522.5 52031.0 41723.0 42274.2 42880.6 43375.6 44429.1 42020.4 42612.8 42686.6 43309.0 43515.8 40864.0 41217.6 41797.6 41819.0 41863.0 36624.8 36904.3 37513.2 38523.8 38971.6 25874.5 26200.5 26275.7 26638.2 26767.6 13:17:11 INFO - PROCESS | 28170 | 13:17:11 INFO - PROCESS | 28170 | [#2] jquery.html Cycles:180 Average:28065.01 Median:2203.00 stddev:88429.60 (4014.0%) stddev-sans-first:88653.24 13:17:11 INFO - PROCESS | 28170 | Values: 385.4 388.2 389.3 392.5 392.6 14680.1 14919.7 16703.6 18438.6 18449.0 17889.5 18373.5 18428.0 18567.2 18870.1 6031.0 6250.0 6273.2 6278.5 6305.2 4609.3 4716.7 4756.1 6158.3 6221.6 5496.8 5686.2 7062.3 7065.0 7078.7 5562.8 5596.5 5597.4 5604.0 5605.5 5335.9 5603.0 5623.9 5625.6 5632.3 13631.4 15338.8 20917.5 21533.9 21541.8 2178.5 2227.5 2243.5 2319.8 2356.0 9865.7 10007.2 10236.7 10976.3 13320.8 1857.7 1919.0 1952.0 1969.8 1976.2 59437.4 60479.7 61334.4 62691.7 63268.0 10895.1 11010.8 11011.2 11106.8 11128.3 14328.5 14514.6 14542.4 14555.6 14575.7 8419.7 8454.0 8509.4 8572.8 8627.7 8095.7 8127.6 8174.6 8180.3 8284.0 4361.7 4530.6 4699.5 4790.2 4831.1 1882.0 1914.3 1928.8 1937.2 1956.1 1002.7 1034.5 1059.9 1085.8 1097.3 15160.5 17096.1 17158.2 17655.3 17700.8 955.4 1018.2 1022.7 1030.8 1072.6 8832.0 9197.7 9265.1 9325.1 9436.5 500227.0 501075.0 535753.0 581546.0 585478.0 47878.0 48273.5 51432.0 74275.6 77247.6 1215.7 1226.0 1227.7 1229.6 1236.8 14216.5 14677.8 14678.0 14832.6 15846.0 31380.0 34430.5 35812.3 36588.8 37258.6 49178.0 49533.8 50174.0 50516.7 52919.9 10408.9 10614.3 10879.6 10904.0 11083.4 10335.9 11853.3 12173.1 12200.8 12419.3 3097.6 4654.6 6020.7 10924.5 11134.6 11337.9 11435.8 11452.5 11515.3 11617.6 7867.6 8177.8 8179.0 8312.1 11590.3 8203.4 10758.8 10901.8 11045.4 11049.8 10478.8 10795.4 10905.6 11042.7 11185.9 13:17:11 INFO - PROCESS | 28170 | 13:17:11 INFO - PROCESS | 28170 | [#3] mootools.html Cycles:180 Average:5711.48 Median:6299.62 stddev:2941.76 (46.7%) stddev-sans-first:2932.37 13:17:11 INFO - PROCESS | 28170 | Values: 1425.0 1550.4 1556.1 1769.4 1881.8 7346.3 7540.3 7795.9 7979.9 8022.9 7895.1 7896.4 7993.6 7998.2 8006.4 2370.1 2406.2 2408.0 2409.3 2411.8 2376.5 2395.0 2410.4 2411.9 2413.4 2344.6 2359.1 2361.1 2396.9 2400.3 2351.9 2360.1 2366.5 2368.8 2420.9 2423.5 2433.1 2433.7 2443.1 2448.8 8067.0 8090.1 8117.5 8122.6 8124.1 4914.0 5046.4 5055.0 5059.2 5061.0 3066.0 3088.4 3126.3 3135.2 3156.8 1178.8 2005.3 2005.6 2005.8 2049.2 11273.5 11433.4 11437.3 11467.3 11497.5 4387.2 4389.1 4460.1 4575.6 4576.7 9926.7 9979.8 9985.4 9990.6 10003.8 5064.7 5095.3 5098.3 5103.0 5107.8 4040.9 4082.1 4368.7 4425.3 4612.9 3823.9 3840.3 3860.1 3897.2 3904.0 1166.5 1193.6 1200.4 1205.3 1214.4 1373.9 1382.5 1394.1 1408.6 1409.8 7579.1 7786.1 7790.2 7865.5 7928.6 516.8 520.7 521.7 527.1 528.5 6207.3 6216.1 6296.1 6298.1 6301.1 9366.3 9719.1 9729.1 9737.9 9749.8 9303.4 9575.3 9642.7 9659.2 9663.4 7583.5 7593.5 7650.8 7653.7 7663.8 7157.1 7172.5 7176.5 7184.0 7461.1 8542.6 8655.4 8770.1 8885.6 8922.7 8806.8 9089.0 9106.9 9124.7 9218.4 6293.6 6387.3 6397.3 7131.6 7163.7 7549.4 7714.3 7732.8 7739.0 7741.7 7021.0 7111.1 7228.2 7291.9 7378.9 7127.6 7163.7 7184.9 7210.0 7270.3 7162.6 7433.2 7446.9 7471.4 7524.7 6767.0 6795.6 6815.7 6826.6 6828.1 6939.2 6989.2 6989.2 6989.7 7086.5 13:17:11 INFO - PROCESS | 28170 | 13:17:11 INFO - PROCESS | 28170 | [#4] prototype.html Cycles:180 Average:5374.48 Median:6079.18 stddev:1586.59 (26.1%) stddev-sans-first:1545.97 13:17:11 INFO - PROCESS | 28170 | Values: 372.1 373.2 373.9 374.4 381.7 5983.3 6012.5 6022.8 6039.3 6065.1 5678.9 5756.4 5793.6 5925.9 5951.9 4669.8 4672.1 4685.1 4694.1 4699.6 4506.9 4689.2 4708.2 4709.7 4715.1 4548.0 4563.7 4638.0 4657.8 4691.4 4632.0 4646.1 4649.7 4654.2 4674.2 4159.8 4166.7 4172.8 4179.3 4182.1 5559.2 5724.2 5726.4 5729.1 5730.1 5361.8 5362.9 5367.8 5368.9 5416.2 6379.6 6393.6 6396.6 6402.1 6405.3 4536.4 4545.7 4546.6 4549.0 4551.1 6447.6 6543.9 6618.3 6626.5 6627.9 4656.2 4659.6 4662.1 4663.2 4665.7 4721.1 4722.6 4725.7 4726.3 4726.7 5371.3 5372.7 5375.3 5380.9 5381.1 6233.5 6332.4 6386.4 6388.9 6399.4 1638.3 1652.1 1653.6 1655.3 1657.5 1119.5 1123.5 1124.7 1140.6 1145.7 6156.0 6168.4 6169.4 6173.1 6176.5 6374.8 6572.4 6582.3 6582.4 6588.1 6041.5 6093.3 6230.4 6242.5 6249.7 3522.8 3602.6 3604.1 3605.4 3605.4 6741.4 6795.2 6832.7 6913.9 6914.8 6783.2 6800.1 6800.5 6804.9 6805.1 6796.1 6816.3 6819.0 6825.5 6825.6 6540.3 6562.9 6583.0 6619.7 6633.8 6491.4 6503.8 6518.5 6521.4 6531.4 6805.8 6828.4 6830.1 6832.2 6835.7 4680.0 4680.0 4682.3 4685.4 4687.0 6429.3 6510.4 6568.5 6588.3 6598.9 6401.6 6410.8 6413.3 6414.0 6418.5 6341.6 6400.4 6404.9 6410.7 6412.8 6279.9 6300.5 6306.7 6308.0 6314.8 6490.4 6492.5 6495.5 6496.2 6502.3 6161.7 6349.7 6351.4 6357.3 6358.1 13:17:11 INFO - PROCESS | 28170 | 13:17:11 INFO - PROCESS | 28170 | [#5] yui.html Cycles:180 Average:14412.94 Median:24849.79 stddev:16342.04 (65.8%) stddev-sans-first:16355.80 13:17:11 INFO - PROCESS | 28170 | Values: 777.0 806.2 858.2 880.2 961.1 13275.0 13344.9 13403.3 13426.6 13580.7 12997.7 13232.9 13272.0 13281.3 13288.8 764.9 771.5 893.9 902.9 912.0 902.9 905.5 910.0 911.4 913.7 954.1 955.9 956.2 956.6 956.7 779.6 780.1 938.7 940.2 952.4 700.0 702.8 703.5 705.8 707.2 14624.5 14654.6 14677.4 14678.3 14717.0 13380.3 13805.0 13833.6 13916.6 13990.9 11071.7 11117.7 11118.1 11305.4 11310.9 3669.9 3723.5 3753.8 3766.7 3794.3 49010.0 52774.0 52794.2 53009.5 53027.7 10907.7 10989.8 11169.4 11281.3 11315.5 19734.9 20035.8 20055.3 20055.4 20140.8 7551.3 7865.4 7923.8 7959.2 8159.1 4150.4 4236.0 4304.7 4343.8 4355.2 3143.4 3155.2 3177.3 3191.5 3195.3 569.5 581.6 584.8 588.6 594.0 603.6 671.5 672.7 705.6 714.2 9050.0 9665.0 9837.9 9838.5 9875.7 543.7 558.0 574.9 688.8 694.2 4402.6 4414.2 4449.3 4532.1 4584.7 56468.2 56725.4 56984.0 57154.7 62574.4 50812.2 51164.0 51466.5 52021.7 52797.7 45250.3 45464.5 45601.8 47333.0 47840.8 9037.3 9135.1 9255.4 9268.0 9306.4 35170.0 35717.6 37254.4 37287.6 37570.4 45646.3 45783.0 45836.5 46160.0 47433.5 11870.9 12141.2 12170.6 12269.4 12347.2 13076.2 13274.7 13494.6 13501.5 13506.7 11431.9 11544.1 11685.2 11855.9 12132.3 11536.3 11697.6 11799.8 11854.3 12127.3 10839.7 11278.7 11319.6 11800.8 12574.8 9763.7 9904.7 10149.1 10293.1 10342.1 10297.0 10316.6 10478.6 10638.8 10709.8 13:17:11 INFO - PROCESS | 28170 | -------- Summary: end -------- 13:17:11 INFO - PROCESS | 28170 | 13:17:11 INFO - TEST-INFO | 28170: exit 0 13:17:11 INFO - TEST-OK | dromaeo_css | took 1110681ms 13:17:11 INFO - TEST-START | kraken 13:17:11 INFO - operating with platform_type : linux_ 13:17:11 INFO - Initialising browser for kraken test... 13:17:11 INFO - TEST-INFO | started process 28367 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC9HO9s/profile http://localhost:35032/getInfo.html) 13:17:16 INFO - PROCESS | 28367 | __metrics Screen width/height:1600/1200 13:17:16 INFO - PROCESS | 28367 | colorDepth:24 13:17:16 INFO - PROCESS | 28367 | Browser inner width/height: 1024/697 13:17:16 INFO - PROCESS | 28367 | __metrics 13:17:16 INFO - PROCESS | 28367 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:17:17 INFO - TEST-INFO | 28367: exit 0 13:17:17 INFO - Browser initialized. 13:17:17 INFO - Running cycle 1/1 for kraken test... 13:17:17 INFO - TEST-INFO | started process 28455 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpC9HO9s/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:17:29 INFO - PROCESS | 28455 | RSS: Main: 136597504 13:17:29 INFO - PROCESS | 28455 | 13:17:31 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35032/tests/kraken/driver.html?testName=audio-beat-detection) 13:17:32 INFO - PROCESS | 28455 | RSS: Main: 170856448 13:17:32 INFO - PROCESS | 28455 | 13:17:34 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35032/tests/kraken/driver.html?testName=audio-dft) 13:17:35 INFO - PROCESS | 28455 | RSS: Main: 169377792 13:17:35 INFO - PROCESS | 28455 | 13:17:38 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35032/tests/kraken/driver.html?testName=audio-fft) 13:17:38 INFO - PROCESS | 28455 | RSS: Main: 165818368 13:17:38 INFO - PROCESS | 28455 | 13:17:40 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35032/tests/kraken/driver.html?testName=audio-oscillator) 13:17:41 INFO - PROCESS | 28455 | RSS: Main: 166846464 13:17:41 INFO - PROCESS | 28455 | 13:17:43 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35032/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:17:44 INFO - PROCESS | 28455 | RSS: Main: 165945344 13:17:44 INFO - PROCESS | 28455 | 13:17:47 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35032/tests/kraken/driver.html?testName=imaging-darkroom) 13:17:47 INFO - PROCESS | 28455 | RSS: Main: 165597184 13:17:47 INFO - PROCESS | 28455 | 13:17:51 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35032/tests/kraken/driver.html?testName=imaging-desaturate) 13:17:51 INFO - PROCESS | 28455 | RSS: Main: 166989824 13:17:51 INFO - PROCESS | 28455 | 13:17:54 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35032/tests/kraken/driver.html?testName=json-parse-financial) 13:17:54 INFO - PROCESS | 28455 | RSS: Main: 165294080 13:17:54 INFO - PROCESS | 28455 | 13:17:56 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35032/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:17:57 INFO - PROCESS | 28455 | RSS: Main: 168841216 13:17:57 INFO - PROCESS | 28455 | 13:17:58 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35032/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:17:59 INFO - PROCESS | 28455 | RSS: Main: 166940672 13:17:59 INFO - PROCESS | 28455 | 13:18:01 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35032/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:18:01 INFO - PROCESS | 28455 | RSS: Main: 171655168 13:18:01 INFO - PROCESS | 28455 | 13:18:04 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35032/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:18:04 INFO - PROCESS | 28455 | RSS: Main: 176418816 13:18:04 INFO - PROCESS | 28455 | 13:18:07 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35032/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:18:07 INFO - PROCESS | 28455 | RSS: Main: 174817280 13:18:07 INFO - PROCESS | 28455 | 13:18:09 INFO - PROCESS | 28455 | Cycle 1(1): loaded http://localhost:35032/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35032/tests/kraken/driver.html?testName=ai-astar) 13:18:09 INFO - PROCESS | 28455 | RSS: Main: 234856448 13:18:09 INFO - PROCESS | 28455 | 13:18:09 INFO - PROCESS | 28455 | __start_tp_report 13:18:09 INFO - PROCESS | 28455 | _x_x_mozilla_page_load 13:18:09 INFO - PROCESS | 28455 | _x_x_mozilla_page_load_details 13:18:09 INFO - PROCESS | 28455 | |i|pagename|runs| 13:18:09 INFO - PROCESS | 28455 | |0;ai-astar;110;110;105;108;110;109;99;109;109;107 13:18:09 INFO - PROCESS | 28455 | |1;audio-beat-detection;150;125;153;164;123;154;155;135;166;126 13:18:09 INFO - PROCESS | 28455 | |2;audio-dft;160;160;160;162;160;163;160;164;161;160 13:18:09 INFO - PROCESS | 28455 | |3;audio-fft;76;77;75;163;72;73;73;73;178;73 13:18:09 INFO - PROCESS | 28455 | |4;audio-oscillator;95;96;140;94;97;95;140;94;96;143 13:18:09 INFO - PROCESS | 28455 | |5;imaging-gaussian-blur;109;108;109;109;109;109;109;109;110;109 13:18:09 INFO - PROCESS | 28455 | |6;imaging-darkroom;145;146;146;145;147;145;146;146;147;147 13:18:09 INFO - PROCESS | 28455 | |7;imaging-desaturate;96;96;95;96;96;96;96;96;96;96 13:18:09 INFO - PROCESS | 28455 | |8;json-parse-financial;52;54;55;55;54;54;54;54;56;52 13:18:09 INFO - PROCESS | 28455 | |9;json-stringify-tinderbox;64;64;64;64;64;65;64;64;65;64 13:18:09 INFO - PROCESS | 28455 | |10;stanford-crypto-aes;77;79;79;78;79;84;79;78;78;78 13:18:09 INFO - PROCESS | 28455 | |11;stanford-crypto-ccm;115;113;111;117;111;110;120;117;118;130 13:18:09 INFO - PROCESS | 28455 | |12;stanford-crypto-pbkdf2;143;141;142;142;140;130;143;153;145;143 13:18:09 INFO - PROCESS | 28455 | |13;stanford-crypto-sha256-iterative;65;65;66;64;64;64;66;64;67;64 13:18:09 INFO - PROCESS | 28455 | __end_tp_report 13:18:09 INFO - PROCESS | 28455 | __start_cc_report 13:18:09 INFO - PROCESS | 28455 | _x_x_mozilla_cycle_collect,926 13:18:09 INFO - PROCESS | 28455 | __end_cc_report 13:18:09 INFO - PROCESS | 28455 | __startTimestamp1458073089889__endTimestamp 13:18:09 INFO - PROCESS | 28455 | 13:18:09 INFO - PROCESS | 28455 | ------- Summary: start ------- 13:18:09 INFO - PROCESS | 28455 | Number of tests: 14 13:18:09 INFO - PROCESS | 28455 | 13:18:09 INFO - PROCESS | 28455 | [#0] ai-astar Cycles:10 Average:107.60 Median:109.50 stddev:3.41 (3.1%) stddev-sans-first:3.50 13:18:09 INFO - PROCESS | 28455 | Values: 110.0 110.0 105.0 108.0 110.0 109.0 99.0 109.0 109.0 107.0 13:18:09 INFO - PROCESS | 28455 | 13:18:09 INFO - PROCESS | 28455 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:153.50 stddev:16.39 (10.7%) stddev-sans-first:17.29 13:18:09 INFO - PROCESS | 28455 | Values: 150.0 125.0 153.0 164.0 123.0 154.0 155.0 135.0 166.0 126.0 13:18:09 INFO - PROCESS | 28455 | 13:18:09 INFO - PROCESS | 28455 | [#2] audio-dft Cycles:10 Average:161.00 Median:160.50 stddev:1.49 (0.9%) stddev-sans-first:1.54 13:18:09 INFO - PROCESS | 28455 | Values: 160.0 160.0 160.0 162.0 160.0 163.0 160.0 164.0 161.0 160.0 13:18:09 INFO - PROCESS | 28455 | 13:18:09 INFO - PROCESS | 28455 | [#3] audio-fft Cycles:10 Average:93.30 Median:73.00 stddev:40.87 (56.0%) stddev-sans-first:42.87 13:18:09 INFO - PROCESS | 28455 | Values: 76.0 77.0 75.0 163.0 72.0 73.0 73.0 73.0 178.0 73.0 13:18:09 INFO - PROCESS | 28455 | 13:18:09 INFO - PROCESS | 28455 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:95.00 stddev:22.12 (23.3%) stddev-sans-first:22.87 13:18:09 INFO - PROCESS | 28455 | Values: 95.0 96.0 140.0 94.0 97.0 95.0 140.0 94.0 96.0 143.0 13:18:09 INFO - PROCESS | 28455 | 13:18:09 INFO - PROCESS | 28455 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 13:18:09 INFO - PROCESS | 28455 | Values: 109.0 108.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 13:18:09 INFO - PROCESS | 28455 | 13:18:09 INFO - PROCESS | 28455 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 13:18:09 INFO - PROCESS | 28455 | Values: 145.0 146.0 146.0 145.0 147.0 145.0 146.0 146.0 147.0 147.0 13:18:09 INFO - PROCESS | 28455 | 13:18:09 INFO - PROCESS | 28455 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:18:09 INFO - PROCESS | 28455 | Values: 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 13:18:09 INFO - PROCESS | 28455 | 13:18:09 INFO - PROCESS | 28455 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:1.25 (2.3%) stddev-sans-first:1.09 13:18:09 INFO - PROCESS | 28455 | Values: 52.0 54.0 55.0 55.0 54.0 54.0 54.0 54.0 56.0 52.0 13:18:09 INFO - PROCESS | 28455 | 13:18:09 INFO - PROCESS | 28455 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 13:18:09 INFO - PROCESS | 28455 | Values: 64.0 64.0 64.0 64.0 64.0 65.0 64.0 64.0 65.0 64.0 13:18:09 INFO - PROCESS | 28455 | 13:18:09 INFO - PROCESS | 28455 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:1.91 (2.4%) stddev-sans-first:1.90 13:18:09 INFO - PROCESS | 28455 | Values: 77.0 79.0 79.0 78.0 79.0 84.0 79.0 78.0 78.0 78.0 13:18:09 INFO - PROCESS | 28455 | 13:18:09 INFO - PROCESS | 28455 | [#11] stanford-crypto-ccm Cycles:10 Average:116.20 Median:117.00 stddev:5.90 (5.0%) stddev-sans-first:6.24 13:18:09 INFO - PROCESS | 28455 | Values: 115.0 113.0 111.0 117.0 111.0 110.0 120.0 117.0 118.0 130.0 13:18:09 INFO - PROCESS | 28455 | 13:18:09 INFO - PROCESS | 28455 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.20 Median:143.00 stddev:5.59 (3.9%) stddev-sans-first:5.93 13:18:09 INFO - PROCESS | 28455 | Values: 143.0 141.0 142.0 142.0 140.0 130.0 143.0 153.0 145.0 143.0 13:18:09 INFO - PROCESS | 28455 | 13:18:09 INFO - PROCESS | 28455 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 13:18:09 INFO - PROCESS | 28455 | Values: 65.0 65.0 66.0 64.0 64.0 64.0 66.0 64.0 67.0 64.0 13:18:09 INFO - PROCESS | 28455 | -------- Summary: end -------- 13:18:09 INFO - PROCESS | 28455 | 13:18:10 INFO - TEST-INFO | 28455: exit 0 13:18:10 INFO - TEST-OK | kraken | took 59029ms 13:18:10 INFO - TEST-START | v8_7 13:18:10 INFO - operating with platform_type : linux_ 13:18:10 INFO - Initialising browser for v8_7 test... 13:18:10 INFO - TEST-INFO | started process 28708 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpP2YH8c/profile http://localhost:35032/getInfo.html) 13:18:14 INFO - PROCESS | 28708 | __metrics Screen width/height:1600/1200 13:18:14 INFO - PROCESS | 28708 | colorDepth:24 13:18:14 INFO - PROCESS | 28708 | Browser inner width/height: 1024/697 13:18:14 INFO - PROCESS | 28708 | __metrics 13:18:15 INFO - PROCESS | 28708 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:18:16 INFO - TEST-INFO | 28708: exit 0 13:18:16 INFO - Browser initialized. 13:18:16 INFO - Running cycle 1/1 for v8_7 test... 13:18:16 INFO - TEST-INFO | started process 28797 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpP2YH8c/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:28 INFO - PROCESS | 28797 | RSS: Main: 137277440 13:18:28 INFO - PROCESS | 28797 | 13:18:50 INFO - PROCESS | 28797 | Cycle 1(1): loaded http://localhost:35032/tests/v8_7/run.html (next: http://localhost:35032/tests/v8_7/run.html) 13:18:50 INFO - PROCESS | 28797 | RSS: Main: 421224448 13:18:50 INFO - PROCESS | 28797 | 13:18:50 INFO - PROCESS | 28797 | __start_tp_report 13:18:50 INFO - PROCESS | 28797 | _x_x_mozilla_page_load 13:18:50 INFO - PROCESS | 28797 | _x_x_mozilla_page_load_details 13:18:50 INFO - PROCESS | 28797 | |i|pagename|runs| 13:18:50 INFO - PROCESS | 28797 | |0;Richards;167.22408026755852 13:18:50 INFO - PROCESS | 28797 | |1;DeltaBlue;169.7792869269949 13:18:50 INFO - PROCESS | 28797 | |2;Encrypt;279.2516056967328 13:18:50 INFO - PROCESS | 28797 | |3;Decrypt;5240.837696335078 13:18:50 INFO - PROCESS | 28797 | |4;RayTrace;966.1835748792271 13:18:50 INFO - PROCESS | 28797 | |5;Earley;558.9714924538848 13:18:50 INFO - PROCESS | 28797 | |6;Boyer;10691.489361702128 13:18:50 INFO - PROCESS | 28797 | |7;RegExp;40960 13:18:50 INFO - PROCESS | 28797 | |8;Splay;509.1649694501018 13:18:50 INFO - PROCESS | 28797 | |9;NavierStokes;4822.115384615385 13:18:50 INFO - PROCESS | 28797 | __end_tp_report 13:18:50 INFO - PROCESS | 28797 | __startTimestamp1458073130624__endTimestamp 13:18:50 INFO - PROCESS | 28797 | 13:18:50 INFO - PROCESS | 28797 | ------- Summary: start ------- 13:18:50 INFO - PROCESS | 28797 | Number of tests: 10 13:18:50 INFO - PROCESS | 28797 | 13:18:50 INFO - PROCESS | 28797 | [#0] Richards Cycles:1 Average:167.22 Median:167.22 stddev:0.00 (0.0%) 13:18:50 INFO - PROCESS | 28797 | Values: 167.2 13:18:50 INFO - PROCESS | 28797 | 13:18:50 INFO - PROCESS | 28797 | [#1] DeltaBlue Cycles:1 Average:169.78 Median:169.78 stddev:0.00 (0.0%) 13:18:50 INFO - PROCESS | 28797 | Values: 169.8 13:18:50 INFO - PROCESS | 28797 | 13:18:50 INFO - PROCESS | 28797 | [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 13:18:50 INFO - PROCESS | 28797 | Values: 279.3 13:18:50 INFO - PROCESS | 28797 | 13:18:50 INFO - PROCESS | 28797 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 13:18:50 INFO - PROCESS | 28797 | Values: 5240.8 13:18:50 INFO - PROCESS | 28797 | 13:18:50 INFO - PROCESS | 28797 | [#4] RayTrace Cycles:1 Average:966.18 Median:966.18 stddev:0.00 (0.0%) 13:18:50 INFO - PROCESS | 28797 | Values: 966.2 13:18:50 INFO - PROCESS | 28797 | 13:18:50 INFO - PROCESS | 28797 | [#5] Earley Cycles:1 Average:558.97 Median:558.97 stddev:0.00 (0.0%) 13:18:50 INFO - PROCESS | 28797 | Values: 559.0 13:18:50 INFO - PROCESS | 28797 | 13:18:50 INFO - PROCESS | 28797 | [#6] Boyer Cycles:1 Average:10691.49 Median:10691.49 stddev:0.00 (0.0%) 13:18:50 INFO - PROCESS | 28797 | Values: 10691.5 13:18:50 INFO - PROCESS | 28797 | 13:18:50 INFO - PROCESS | 28797 | [#7] RegExp Cycles:1 Average:40960.00 Median:40960.00 stddev:0.00 (0.0%) 13:18:50 INFO - PROCESS | 28797 | Values: 40960.0 13:18:50 INFO - PROCESS | 28797 | 13:18:50 INFO - PROCESS | 28797 | [#8] Splay Cycles:1 Average:509.16 Median:509.16 stddev:0.00 (0.0%) 13:18:50 INFO - PROCESS | 28797 | Values: 509.2 13:18:50 INFO - PROCESS | 28797 | 13:18:50 INFO - PROCESS | 28797 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 13:18:50 INFO - PROCESS | 28797 | Values: 4822.1 13:18:50 INFO - PROCESS | 28797 | -------- Summary: end -------- 13:18:50 INFO - PROCESS | 28797 | 13:18:51 INFO - TEST-INFO | 28797: exit 0 13:18:51 INFO - TEST-OK | v8_7 | took 40672ms 13:18:51 INFO - SUITE-END | took 1210s 13:18:51 INFO - Completed test suite (00:20:10) 13:18:51 INFO - Working with test: dromaeo_css 13:18:51 INFO - Generating results file: dromaeo_css 13:18:51 INFO - Working with test: kraken 13:18:51 INFO - Generating results file: kraken 13:18:51 INFO - javascript benchmark 13:18:51 INFO - Working with test: v8_7 13:18:51 INFO - Generating results file: v8_7 13:18:51 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:18:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 13:18:51 INFO - process_Request line: dromaeo_css 7189.21 graph.html#tests=[[72,53,35]] 13:18:51 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:18:51 INFO - process_Request line: kraken 1487.30 graph.html#tests=[[232,53,35]] 13:18:51 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:18:52 INFO - process_Request line: v8_7 21969.52 graph.html#tests=[[230,53,35]] 13:18:52 INFO - RETURN: dromaeo_css: 7189.21 13:18:52 INFO - RETURN: kraken: 1487.30 13:18:52 INFO - RETURN: v8_7: 21969.52 13:18:52 INFO - javascript benchmark 13:18:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3161.225499752561, 3244.9675503244976, 3246.5130230465443, 3257.1694217974414, 3292.8682852685893, 5211.0, 5225.137852254383, 5229.8169564065265, 5234.685918844872, 5237.10969135247, 5230.2416149658275, 5237.266782650432, 5247.370315562129, 5253.949210157964, 5297.178937264721, 4703.059388122372, 4776.665633405663, 4801.351817504627, 4832.767644250729, 4875.63432742544, 4736.573708366246, 4743.241081426972, 4785.71285722856, 4808.134535783557, 4821.951780482203, 4792.281157826319, 4820.493848145947, 4843.370361852954, 4856.4172299323955, 4876.122297986361, 4718.457377401608, 4768.451628062782, 4815.927761083586, 4837.492063333352, 4838.733869637169, 4718.05638872227, 4748.715077095385, 4775.307580400857, 4785.928211076836, 4806.663533552653, 5021.824236151717, 5024.321716568253, 5028.874278143076, 5048.368953880765, 5050.898982020376, 5449.7275136243425, 5532.446755324436, 5544.085225937715, 5549.861253468655, 5561.944380556183, 5602.7758889644365, 5640.041192997201, 5659.037963546207, 5670.801521946753, 5703.0, 5239.476052394768, 5267.47325267474, 5271.472852714698, 5272.31459910213, 5278.683279003272, 5528.75120619565, 5623.8875222496135, 5680.204771332017, 5731.254936858182, 5744.396838331999, 5537.446255374511, 5542.8337149885565, 5547.861303467445, 5551.3893471718075, 5553.0004599172535, 5564.1931919871395, 5606.355269144019, 5610.607257492018, 5614.242077319591, 5620.91568626471, 5457.154141108134, 5544.362398324163, 5546.140348246028, 5581.246531718247, 5612.466815652507, 5602.691851948182, 5611.579131565068, 5618.4662457066515, 5618.831435056954, 5620.466055724782, 4305.913881722348, 4320.395144679747, 4337.024169561886, 4347.478302603708, 4368.08270263242, 3858.5176852893387, 3889.5527014393706, 3928.233994371127, 3943.2310699413338, 3947.111899822517, 5244.659097158673, 5250.842474725764, 5266.3943646480375, 5267.525922666979, 5283.550898173621, 5550.306211723535, 5553.750081246354, 5562.9443705563235, 5568.721563921868, 5574.9721251393485, 5102.69383836971, 5221.556167725786, 5242.318498595158, 5295.470452954751, 5327.81352652663, 4842.467328593852, 4860.125177468019, 4877.073356062337, 4889.2910527973245, 4920.876978075506, 5661.348944871393, 5766.509846662997, 5767.826965191051, 5774.133879917962, 5784.797532086441, 5502.697351645698, 5573.832785016456, 5648.774049037993, 5690.146478028329, 5709.628874123168, 5720.941625799241, 5764.164196191613, 5770.567207459373, 5773.336066352424, 5774.82675519735, 5377.489138531833, 5512.4211957743855, 5541.889162216814, 5552.7778888843995, 5576.470235327637, 5651.350094739158, 5710.400407957105, 5717.42825717425, 5729.0, 5734.541236701138, 5361.946380536145, 5364.678119312854, 5372.1404575269335, 5384.919226211531, 5397.703126327932, 5389.676619402849, 5410.756515956713, 5442.5645948323245, 5447.155690867922, 5503.807366742145, 5358.169483730028, 5363.27595774581, 5385.54222891043, 5388.057090009154, 5397.595180361567, 5478.205660179331, 5538.252335934597, 5540.445955404427, 5551.417101204477, 5574.247476590771, 5320.627556071038, 5363.946360536344, 5410.48600382963, 5425.321834770653, 5466.863328416822], "unit": "score", "name": "dojo.html", "value": 5173.373010662817}, {"lowerIsBetter": false, "replicates": [559.7453158812738, 574.482965331202, 581.4476247564814, 588.2411688921292, 596.1981135372923, 31464.213394665116, 38721.80639096804, 39053.0, 39104.60895391049, 39179.0, 47007.764961175235, 47841.76079119599, 48030.27954580684, 48075.75962120185, 48095.759521202344, 9076.8638470423, 9231.169194772468, 9284.953575232114, 9290.163885250326, 9292.210162136227, 9024.503652299121, 9170.587323570422, 9185.357025008252, 9195.586198621078, 9207.079292070774, 9196.126367995063, 9231.215346695539, 9308.488033158173, 9308.8603670945, 9313.068693130666, 9132.0, 9152.405093668891, 9213.769655758593, 9234.630614775435, 9237.399569028059, 8977.551122443918, 9155.221806146486, 9157.862632060524, 9158.542072896329, 9161.908380916238, 43024.56975430268, 43352.13295734099, 43458.565414345765, 43508.782456087836, 43535.564644353464, 3627.220147668264, 3862.0731024554184, 4040.656544193747, 4146.979265103685, 4222.577742225752, 32282.838585807156, 32589.185270368194, 32798.3440331192, 33050.0, 33282.535207072535, 4186.602272784081, 4216.241076606209, 4223.704340696153, 4281.828726850922, 4296.978515107405, 275743.0, 276205.0, 277552.0, 278919.0, 279400.0, 59079.40920590825, 59223.70388148118, 64309.356906431276, 64750.0, 66315.0, 60960.69519652462, 61059.0, 61443.6927815367, 61465.69267153636, 61483.69258153681, 18286.63426731458, 18484.72272915907, 18509.907450462662, 18527.351542695942, 18528.44414667562, 13617.591472255848, 13631.727365452636, 13667.794983075262, 13700.0, 13713.794293085612, 21385.465363366042, 22271.665925011137, 22424.55150896973, 22437.21469748551, 22525.4368640782, 8083.100471389219, 8361.247487726134, 8363.623636936352, 8364.205400486944, 8366.45618034838, 1062.3041907550567, 1138.9430528473708, 1139.333489908413, 1146.2893006336126, 1150.551284998851, 30793.230169245948, 30870.69129308678, 31025.224369390944, 31098.067057987842, 32144.0, 1156.6819124740764, 1168.696139003865, 1193.665773583398, 1206.3003457994341, 1251.455616806692, 14052.0, 15408.922955385151, 15832.92083539598, 16093.436729714638, 16228.107454090139, 180278.0, 181108.0, 181173.0, 181270.0, 182082.0, 49172.508274917505, 49842.0, 56990.43009569851, 57260.71369643125, 57434.0, 1471.8380978092616, 1472.0578829549097, 1480.3782411387244, 1514.7349213887526, 1602.0227661126703, 28347.85826070939, 30268.727040408598, 30575.694243057285, 30877.536836947016, 30951.535726964565, 45345.31982020338, 47661.28508072451, 48462.75768621134, 52136.0, 53060.4693953071, 373550.0, 380022.0, 380151.0, 381467.0, 383421.0, 46767.29849052335, 46895.531044690484, 47341.0, 47699.0, 48280.0, 50762.0, 50821.0, 50844.49155508397, 51522.48477515177, 52031.0, 41723.0, 42274.15451690887, 42880.57119428766, 43375.566244337155, 44429.111417770815, 42020.369694454, 42612.786936065124, 42686.5731342695, 43309.0, 43515.78242108896, 40864.0, 41217.58782412137, 41797.582024180585, 41819.0, 41863.0, 36624.81687591651, 36904.29517877883, 37513.2497350046, 38523.80738096291, 38971.6102838968, 25874.48251034931, 26200.475990479703, 26275.73724262733, 26638.200853974413, 26767.598486023115], "unit": "score", "name": "ext.html", "value": 20100.958205101113}, {"lowerIsBetter": false, "replicates": [385.3853104298644, 388.1770646229993, 389.2642904909721, 392.5485691454828, 392.605431541301, 14680.119192848437, 14919.731822795075, 16703.58241043973, 18438.631227375463, 18449.0, 17889.463316100537, 18373.54066148347, 18428.0, 18567.164477598508, 18870.056497175156, 6030.969845150768, 6250.000000000001, 6273.153124328226, 6278.529110316722, 6305.180326557564, 4609.308603709454, 4716.716996980175, 4756.120117778205, 6158.291796443422, 6221.564490485668, 5496.780128794843, 5686.232358631594, 7062.293770622922, 7065.0, 7078.716851325967, 5562.7774889004395, 5596.496315331639, 5597.384287728347, 5604.0, 5605.467480589337, 5335.919961200585, 5603.0, 5623.8594035149445, 5625.634333768333, 5632.295963004624, 13631.386587603582, 15338.846611533854, 20917.47706307339, 21533.892330538405, 21541.78458215429, 2178.498945242603, 2227.509947811479, 2243.5064285857084, 2319.8028167605776, 2355.97644023561, 9865.704028879145, 10007.249456290807, 10236.74408139795, 10976.341419514854, 13320.800187997187, 1857.7399164117035, 1919.0117089698817, 1952.0, 1969.7636283646054, 1976.24902537035, 59437.40562594362, 60479.69760151215, 61334.38665613376, 62691.686541567, 63268.0, 10895.07391871684, 11010.834837477445, 11011.174161937726, 11106.833397499044, 11128.276662016942, 14328.49850255236, 14514.637134071732, 14542.418303267963, 14555.636109097146, 14575.708485830224, 8419.747407577783, 8453.95773021131, 8509.361797865186, 8572.828543429096, 8627.654893804303, 8095.676172953134, 8127.634256458474, 8174.632141553644, 8180.304674102649, 8284.0, 4361.716488428242, 4530.637548996138, 4699.506551812011, 4790.185668436374, 4831.130396528659, 1881.9717704234447, 1914.2821441959265, 1928.7781905080815, 1937.1573365586016, 1956.0610906764548, 1002.7192386131894, 1034.4775888176423, 1059.9470026498643, 1085.7719878825535, 1097.2977294531506, 15160.545183644508, 17096.145192740314, 17158.227879745442, 17655.293788248327, 17700.822991770176, 955.398099197515, 1018.2108865629049, 1022.6676330192569, 1030.8041472120274, 1072.5977758340623, 8832.0, 9197.711706718392, 9265.119813617695, 9325.114114159143, 9436.528173591292, 500227.0, 501075.0, 535753.0, 581546.0, 585478.0, 47878.0, 48273.5172648269, 51431.97136057258, 74275.62862185763, 77247.61376193083, 1215.7143071378218, 1225.96935076622, 1227.7053507158396, 1229.624964385853, 1236.758832027746, 14216.502422415166, 14677.779833302722, 14677.972541921963, 14832.62918427048, 15846.0, 31380.0, 34430.48354274638, 35812.28375432425, 36588.81705591455, 37258.62741372552, 49178.0, 49533.75233123956, 50174.0, 50516.74741626268, 52919.94160116853, 10408.895911040792, 10614.310069845435, 10879.564817407532, 10904.0, 11083.390413527011, 10335.896641033494, 11853.34806585646, 12173.147879648339, 12200.75598488043, 12419.254844709347, 3097.5818264534, 4654.58035299237, 6020.698965051817, 10924.453777310944, 11134.634204797328, 11337.943310283395, 11435.771284574095, 11452.541898323974, 11515.25150865191, 11617.593384231512, 7867.567283799217, 8177.79555511117, 8179.0, 8312.08567057611, 11590.304581725124, 8203.42576019673, 10758.784824303313, 10901.781964360509, 11045.447727613748, 11049.834252486058, 10478.842817357594, 10795.40625265618, 10905.563777448813, 11042.668719938414, 11185.888141118485], "unit": "score", "name": "jquery.html", "value": 8742.415724466251}, {"lowerIsBetter": false, "replicates": [1424.9572512824618, 1550.3798480607757, 1556.0974634711865, 1769.4249368955093, 1881.8024107468716, 7346.338829505344, 7540.321371076602, 7795.883061754071, 7979.92020079799, 8022.91977080229, 7895.0920644125945, 7896.368290536758, 7993.560354180518, 7998.1601931797195, 8006.439549231556, 2370.0519792083132, 2406.181898154627, 2407.963880541793, 2409.3013026222375, 2411.807055435561, 2376.5484557934024, 2395.0419832067137, 2410.4214988402746, 2411.9397015074587, 2413.4328432818274, 2344.5779759643256, 2359.1389142962867, 2361.138184562631, 2396.8681722505257, 2400.3039118655656, 2351.9176828810996, 2360.079568968104, 2366.5030343627773, 2368.751281115484, 2420.854748715065, 2423.5395274897714, 2433.051110067075, 2433.7322894481595, 2443.132687895807, 2448.8408253463645, 8067.031956165239, 8090.069641991128, 8117.512949223065, 8122.553259570721, 8124.146964568753, 4913.950860491421, 5046.369203849519, 5054.974725126388, 5059.241113832918, 5061.038402703512, 3066.0, 3088.382323535302, 3126.296583268769, 3135.2475405902646, 3156.794808337451, 1178.8054970929786, 2005.2780998840406, 2005.5988802239465, 2005.81947624713, 2049.1803278688494, 11273.492692828842, 11433.428328583537, 11437.256578322465, 11467.254628449124, 11497.54009839597, 4387.232234358974, 4389.122175564899, 4460.085682435093, 4575.565321294538, 4576.679632425698, 9926.702198934043, 9979.750506237257, 9985.400875947467, 9990.550425230882, 10003.79992400148, 5064.670796398223, 5095.337606111182, 5098.337216161949, 5103.030424219386, 5107.795688172431, 4040.91918161641, 4082.1427500225286, 4368.694191406571, 4425.336199570091, 4612.884677883013, 3823.9235215296094, 3840.347140986039, 3860.0735823402183, 3897.1815918656835, 3904.04350934023, 1166.4692564882957, 1193.5822462138183, 1200.4477940147456, 1205.3069485046133, 1214.4292182674128, 1373.8763511283832, 1382.4539306973688, 1394.1286695815115, 1408.6126315263384, 1409.7955796409462, 7579.090509138939, 7786.104597971193, 7790.182030886675, 7865.488743231672, 7928.643211055401, 516.7752027867889, 520.7005971566365, 521.7495602111007, 527.0644605824692, 528.4715284715285, 6207.286162091417, 6216.067589861466, 6296.118543403927, 6298.118263443122, 6301.117843501914, 9366.250699943988, 9719.125278724949, 9729.075737804897, 9737.853932191023, 9749.756256093513, 9303.395279306824, 9575.329726919188, 9642.662506812228, 9659.178969787647, 9663.420194788336, 7583.544987300779, 7593.468457208053, 7650.846983060196, 7653.655585498666, 7663.770086897402, 7157.069580954442, 7172.462065345016, 7176.497645164788, 7184.0, 7461.141968673672, 8542.572871356282, 8655.394122411371, 8770.12298770118, 8885.555722213992, 8922.68770593026, 8806.779830504289, 9089.0, 9106.863397048917, 9124.680636177702, 9218.44689318643, 6293.622382657055, 6387.265464471645, 6397.328280530477, 7131.607761573163, 7163.7492687755675, 7549.433792465477, 7714.305712485903, 7732.7680169595005, 7739.032620922385, 7741.651625676971, 7021.0, 7111.146662400338, 7228.241034691282, 7291.8541629168185, 7378.926210737824, 7127.572345659277, 7163.713451462092, 7184.928150718635, 7210.0, 7270.345668889825, 7162.606056666933, 7433.1823499416105, 7446.92553074484, 7471.439642026761, 7524.736634217995, 6767.0, 6795.592264464148, 6815.693293801692, 6826.590404575742, 6828.146481689789, 6939.236683964861, 6989.161300643956, 6989.196242431982, 6989.650517474004, 7086.468514861509], "unit": "score", "name": "mootools.html", "value": 4676.803384608135}, {"lowerIsBetter": false, "replicates": [372.0791042170628, 373.240455672706, 373.91213064929735, 374.40282749015313, 381.692737346436, 5983.252093488314, 6012.458878700922, 6022.789202377918, 6039.275286965571, 6065.059915713061, 5678.858028549278, 5756.366799652035, 5793.6234144780665, 5925.940740592593, 5951.851203719909, 4669.813207471697, 4672.135654903836, 4685.109829132471, 4694.08465349257, 4699.577038066574, 4506.864794056167, 4689.179393606122, 4708.152532544141, 4709.717416954976, 4715.056988602293, 4548.044910568785, 4563.703359281636, 4638.0491999140095, 4657.813687452498, 4691.413573303337, 4631.976840115812, 4646.070785842828, 4649.744264065475, 4654.185517534418, 4674.158651442739, 4159.750414975111, 4166.729162604452, 4172.833086676529, 4179.2895207814745, 4182.100848317596, 5559.221708960748, 5724.198612194296, 5726.3700992890745, 5729.140628905656, 5730.140478928152, 5361.758720857531, 5362.946370536284, 5367.812126575551, 5368.91946620801, 5416.160495123262, 6379.649119298437, 6393.584417012926, 6396.584222025554, 6402.13571167891, 6405.295417504118, 4536.432945881765, 4545.727256364596, 4546.636269098464, 4548.95451045492, 4551.067031258584, 6447.6131432114225, 6543.93456065438, 6618.271990081087, 6626.503012274099, 6627.867442651168, 4656.161890859677, 4659.603933665609, 4662.137504561667, 4663.160631086437, 4665.6734028617675, 4721.126591580569, 4722.645801564828, 4725.692829966041, 4726.26742854858, 4726.71639701619, 5371.328583927009, 5372.650777699437, 5375.3012108425655, 5380.865478362994, 5381.13901775714, 6233.501319894398, 6332.366763323631, 6386.393292637192, 6388.904166437507, 6399.360063993563, 1638.262781748218, 1652.0583267537388, 1653.5783375239478, 1655.2551351891698, 1657.4696097248764, 1119.485036883043, 1123.4888125902694, 1124.746931940307, 1140.5950887434842, 1145.7479354541988, 6156.0, 6168.444839964424, 6169.413905678954, 6173.104899789505, 6176.505879529627, 6374.776882809079, 6572.375624315682, 6582.275949645536, 6582.407583317525, 6588.143541339595, 6041.486473649701, 6093.299270583851, 6230.43926046658, 6242.531810114168, 6249.687515624291, 3522.8238588070494, 3602.567691876939, 3604.0809593553477, 3605.369060414417, 3605.4231322988194, 6741.426978706865, 6795.2185498667295, 6832.6925288362145, 6913.89629155563, 6914.757983470555, 6783.18601767791, 6800.149981252343, 6800.52396332252, 6804.863902722017, 6805.149356330458, 6796.116504854337, 6816.250212476623, 6819.0, 6825.453963682993, 6825.55633883796, 6540.321059476553, 6562.868742625216, 6582.979638156094, 6619.702113404812, 6633.834154146185, 6491.350864913471, 6503.804885853432, 6518.478521718156, 6521.445677117498, 6531.412172904462, 6805.829854253683, 6828.385445309946, 6830.112085428863, 6832.214295355899, 6835.658217089225, 4679.953200467951, 4679.976600116977, 4682.2508398656055, 4685.367475390779, 4686.953130468652, 6429.324920883427, 6510.381513756186, 6568.507361947777, 6588.275289718223, 6598.911179655303, 6401.551891367746, 6410.775622853178, 6413.262474815269, 6413.967930160319, 6418.518611104279, 6341.619502829845, 6400.39196276353, 6404.9039264412, 6410.711517981609, 6412.807615771534, 6279.874402512016, 6300.464460520907, 6306.684665766602, 6307.96846015767, 6314.810555683337, 6490.350964903472, 6492.545521813617, 6495.480361570969, 6496.187976502937, 6502.252240992347, 6161.661108638888, 6349.7142628580905, 6351.396617321347, 6357.332480089709, 6358.0780786784735], "unit": "score", "name": "prototype.html", "value": 4871.744590077811}, {"lowerIsBetter": false, "replicates": [777.0403551613758, 806.1897792718318, 858.1804376820137, 880.1506546182932, 961.0581630002597, 13275.0, 13344.93327533361, 13403.262820544865, 13426.597202083942, 13580.660483487918, 12997.675058123552, 13232.93383533081, 13272.004599655016, 13281.269530175836, 13288.800667989988, 764.858501177284, 771.533222400448, 893.8793262909521, 902.855543113102, 912.0195789526252, 902.9367944243905, 905.4974489158515, 909.9727008189765, 911.3893691226893, 913.6756451459736, 954.0697819625844, 955.9091886270828, 956.2015716876382, 956.5743244256308, 956.689076050283, 779.555653277632, 780.0717146595562, 938.7277689470011, 940.1632547033146, 952.4333021851987, 699.9720011199546, 702.7680865314434, 703.496999645251, 705.8023753349071, 707.1973310292803, 14624.488142915054, 14654.633634159125, 14677.412903483848, 14678.266086695623, 14717.0, 13380.264085475295, 13805.0, 13833.584992450242, 13916.58250252494, 13990.930045349709, 11071.667849964433, 11117.72205694856, 11118.054965327958, 11305.378204198765, 11310.886891131147, 3669.933782706241, 3723.5345581802276, 3753.8498460061564, 3766.679832214265, 3794.335991201556, 49010.0, 52774.0, 52794.20808687873, 53009.46990530084, 53027.73486132583, 10907.672769816918, 10989.780204395867, 11169.38568378747, 11281.266717663326, 11315.547378104948, 19734.901325493567, 20035.799642003683, 20055.29806456767, 20055.398338049883, 20140.798592013893, 7551.320381165721, 7865.370770338359, 7923.762287131395, 7959.164287749819, 8159.061707903667, 4150.418941348214, 4235.97882010588, 4304.677149213821, 4343.804528796211, 4355.216061108968, 3143.449896268144, 3155.1796532901612, 3177.3168768714836, 3191.457452233126, 3195.3130077033547, 569.5159114752428, 581.5667327840786, 584.7690162385834, 588.6497533967282, 593.9813220327073, 603.5895590998076, 671.5198632977445, 672.707372293054, 705.6295444891473, 714.17156098925, 9049.954750226207, 9665.0, 9837.9016209837, 9838.508074596384, 9875.703728888146, 543.6547792151933, 558.0262442038587, 574.9425057494217, 688.8002479281053, 694.2398074108843, 4402.603765661106, 4414.205443020223, 4449.2658711312915, 4532.093581283756, 4584.701994370422, 56468.152977705366, 56725.43274567201, 56984.0, 57154.7142264286, 62574.37425625777, 50812.23781643278, 51164.0, 51466.48533514617, 52021.7398913003, 52797.7360113197, 45250.321245181345, 45464.54535454603, 45601.77199113983, 47333.0, 47840.76079619649, 9037.322200835095, 9135.086491351078, 9255.398399104037, 9267.953660231655, 9306.441613503212, 35170.0, 35717.642823571434, 37254.44118338173, 37287.6271237295, 37570.43644345392, 45646.31530526978, 45783.0, 45836.54163458456, 46160.0, 47433.52566474291, 11870.940645296718, 12141.210821296587, 12170.57402990891, 12269.447874845475, 12347.19743216688, 13076.215427074407, 13274.668133296746, 13494.595162145151, 13501.459941602227, 13506.729865402833, 11431.942840285745, 11544.134189935621, 11685.240459370114, 11855.881441185478, 12132.332721700392, 11536.307821530734, 11697.590584329508, 11799.764004719686, 11854.348010859485, 12127.272363658209, 10839.651222567994, 11278.661640150809, 11319.603813866805, 11800.82298765502, 12574.811377829157, 9763.658271960447, 9904.653337133166, 10149.13442082392, 10293.125084367613, 10342.069213770797, 10297.0, 10316.587336506456, 10478.604977810735, 10638.8404173939, 10709.839352409565], "unit": "score", "name": "yui.html", "value": 6664.87773727488}], "name": "dromaeo_css", "value": 7189.212025620884}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 105.0, 108.0, 110.0, 109.0, 99.0, 109.0, 109.0, 107.0], "unit": "score", "name": "ai-astar", "value": 107.6}, {"lowerIsBetter": true, "replicates": [150.0, 125.0, 153.0, 164.0, 123.0, 154.0, 155.0, 135.0, 166.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.1}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 162.0, 160.0, 163.0, 160.0, 164.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [76.0, 77.0, 75.0, 163.0, 72.0, 73.0, 73.0, 73.0, 178.0, 73.0], "unit": "score", "name": "audio-fft", "value": 93.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 140.0, 94.0, 97.0, 95.0, 140.0, 94.0, 96.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [109.0, 108.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 146.0, 145.0, 147.0, 145.0, 146.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [52.0, 54.0, 55.0, 55.0, 54.0, 54.0, 54.0, 54.0, 56.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.0}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 79.0, 78.0, 79.0, 84.0, 79.0, 78.0, 78.0, 78.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.9}, {"lowerIsBetter": true, "replicates": [115.0, 113.0, 111.0, 117.0, 111.0, 110.0, 120.0, 117.0, 118.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.2}, {"lowerIsBetter": true, "replicates": [143.0, 141.0, 142.0, 142.0, 140.0, 130.0, 143.0, 153.0, 145.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.2}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 64.0, 64.0, 64.0, 66.0, 64.0, 67.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 64.9}], "name": "kraken", "value": 1487.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.22408026755852], "unit": "score", "name": "Richards", "value": 211.10596}, {"lowerIsBetter": false, "replicates": [169.7792869269949], "unit": "score", "name": "DeltaBlue", "value": 389.4350199999999}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [966.1835748792271], "unit": "score", "name": "RayTrace", "value": 765.8886149999998}, {"lowerIsBetter": false, "replicates": [558.9714924538848], "unit": "score", "name": "Earley", "value": 1192.3023069999995}, {"lowerIsBetter": false, "replicates": [10691.489361702128], "unit": "score", "name": "Boyer", "value": 62.335842786069605}, {"lowerIsBetter": false, "replicates": [40960.0], "unit": "score", "name": "RegExp", "value": 22.240844726562486}, {"lowerIsBetter": false, "replicates": [509.1649694501018], "unit": "score", "name": "Splay", "value": 160.04832400000006}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 21969.516180086845}]} 13:18:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "21969.52"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1487.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7189.21"}}} 13:18:52 INFO - Return code: 0 13:18:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:18:52 INFO - # TBPL SUCCESS # 13:18:52 INFO - Running post-action listener: _resource_record_post_action 13:18:52 INFO - Running post-run listener: _resource_record_post_run 13:18:53 INFO - Total resource usage - Wall time: 1225s; CPU: 13.0%; Read bytes: 8192; Write bytes: 463732736; Read time: 256; Write time: 677700 13:18:53 INFO - install - Wall time: 13s; CPU: 16.0%; Read bytes: 4096; Write bytes: 231051264; Read time: 164; Write time: 492336 13:18:53 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 221966336; Read time: 92; Write time: 180244 13:18:53 INFO - Running post-run listener: _upload_blobber_files 13:18:53 INFO - Blob upload gear active. 13:18:53 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:18:53 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:18:53 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:18:53 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:18:53 INFO - (blobuploader) - INFO - Open directory for files ... 13:18:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:18:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:18:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:18:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:18:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:18:54 INFO - (blobuploader) - INFO - Done attempting. 13:18:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 13:18:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:18:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:18:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:18:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:18:55 INFO - (blobuploader) - INFO - Done attempting. 13:18:55 INFO - (blobuploader) - INFO - Iteration through files over. 13:18:55 INFO - Return code: 0 13:18:55 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:18:55 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:18:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d54f5fde5a398e3b9e6be0fef114ec50d9a22245157b594c869f3016aca4cb81e7719e66c2ba6050df938a3dae8c9d344f233f51b9dd37ed53befbe1c1a30ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d38f8a2beb160828b44af9fa287cfbd65d4172169e23fa25745cc747969a4a39407f1a39afcc3ec8baa24ab2b1bdcd366716364f774d17ae991fb54a3a07dcd"} 13:18:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:18:55 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:18:55 INFO - Contents: 13:18:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d54f5fde5a398e3b9e6be0fef114ec50d9a22245157b594c869f3016aca4cb81e7719e66c2ba6050df938a3dae8c9d344f233f51b9dd37ed53befbe1c1a30ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d38f8a2beb160828b44af9fa287cfbd65d4172169e23fa25745cc747969a4a39407f1a39afcc3ec8baa24ab2b1bdcd366716364f774d17ae991fb54a3a07dcd"} 13:18:55 INFO - Running post-run listener: copy_logs_to_upload_dir 13:18:55 INFO - Copying logs to upload dir... 13:18:55 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 13:18:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.782804 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-03-15 13:18:55.371651) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 13:18:55.375781) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d54f5fde5a398e3b9e6be0fef114ec50d9a22245157b594c869f3016aca4cb81e7719e66c2ba6050df938a3dae8c9d344f233f51b9dd37ed53befbe1c1a30ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d38f8a2beb160828b44af9fa287cfbd65d4172169e23fa25745cc747969a4a39407f1a39afcc3ec8baa24ab2b1bdcd366716364f774d17ae991fb54a3a07dcd"} build_url:https://queue.taskcluster.net/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011516 build_url: 'https://queue.taskcluster.net/v1/task/dtxGPp8dRp6q3kjk67JZrg/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6d54f5fde5a398e3b9e6be0fef114ec50d9a22245157b594c869f3016aca4cb81e7719e66c2ba6050df938a3dae8c9d344f233f51b9dd37ed53befbe1c1a30ff", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9d38f8a2beb160828b44af9fa287cfbd65d4172169e23fa25745cc747969a4a39407f1a39afcc3ec8baa24ab2b1bdcd366716364f774d17ae991fb54a3a07dcd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 13:18:55.401582) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 13:18:55.402005) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8783db0840cc980e80bb0bd400000236-1458071869.802633-153179826 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 13:18:55.484546) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 13:18:55.484934) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 13:18:55.485291) ========= ========= Total master_lag: 0.28 =========