builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1456692970.2 results: success (0) buildid: 20160228103115 builduid: f02f334716dc4a7896f9246f9cf88084 revision: 26c6132f3effd41c633aed6adca6268510c6e788 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:10.200850) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:10.201260) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:10.201574) ========= 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=41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.007634 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:10.252649) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:10.252968) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:10.347858) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:10.348170) ========= 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=41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.033934 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:10.397668) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:10.397979) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:10.398357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:10.398674) ========= 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=41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-28 12:56:10-- 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% 35.3M=0s 2016-02-28 12:56:10 (35.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.268974 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:10.684176) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:10.684835) ========= 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=41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.167625 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:10.863868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-28 12:56:10.864271) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 26c6132f3effd41c633aed6adca6268510c6e788 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 26c6132f3effd41c633aed6adca6268510c6e788 --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=41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-28 12:56:10,928 truncating revision to first 12 chars 2016-02-28 12:56:10,928 Setting DEBUG logging. 2016-02-28 12:56:10,928 attempt 1/10 2016-02-28 12:56:10,928 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/26c6132f3eff?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-28 12:56:11,585 unpacking tar archive at: mozilla-inbound-26c6132f3eff/testing/mozharness/ program finished with exit code 0 elapsedTime=0.993885 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-28 12:56:11.873912) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:11.874262) ========= echo 26c6132f3effd41c633aed6adca6268510c6e788 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'26c6132f3effd41c633aed6adca6268510c6e788'] 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=41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 26c6132f3effd41c633aed6adca6268510c6e788 program finished with exit code 0 elapsedTime=0.004492 script_repo_revision: '26c6132f3effd41c633aed6adca6268510c6e788' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:11.926166) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:11.926477) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-28 12:56:11.936560) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-02-28 12:56:11.936859) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:56:12 INFO - MultiFileLogger online at 20160228 12:56:12 in /builds/slave/test-pgo 12:56:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 12:56:12 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:56:12 INFO - {'append_to_log': False, 12:56:12 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:56:12 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 12:56:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:56:12 INFO - 'branch': 'Mozilla-Inbound', 12:56:12 INFO - 'buildbot_json_path': 'buildprops.json', 12:56:12 INFO - 'config_files': ('talos/linux_config.py',), 12:56:12 INFO - 'default_actions': ('clobber', 12:56:12 INFO - 'read-buildbot-config', 12:56:12 INFO - 'download-and-extract', 12:56:12 INFO - 'populate-webroot', 12:56:12 INFO - 'create-virtualenv', 12:56:12 INFO - 'install', 12:56:12 INFO - 'run-tests'), 12:56:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:56:12 INFO - 'download_minidump_stackwalk': True, 12:56:12 INFO - 'download_symbols': 'ondemand', 12:56:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:56:12 INFO - 'tooltool.py': '/tools/tooltool.py', 12:56:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:56:12 INFO - '/tools/misc-python/virtualenv.py')}, 12:56:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:56:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:56:12 INFO - 'installer_path': 'installer.exe', 12:56:12 INFO - 'log_level': 'info', 12:56:12 INFO - 'log_name': 'talos', 12:56:12 INFO - 'log_to_console': True, 12:56:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:56:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:56:12 INFO - 'opt_config_files': (), 12:56:12 INFO - 'pip_index': False, 12:56:12 INFO - 'sps_profile': False, 12:56:12 INFO - 'sps_profile_interval': 0, 12:56:12 INFO - 'suite': 'dromaeojs-e10s', 12:56:12 INFO - 'system_bits': '32', 12:56:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:56:12 INFO - 'title': 'talos-linux64-ix-026', 12:56:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:56:12 INFO - 'use_talos_json': True, 12:56:12 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:56:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:56:12 INFO - 'work_dir': 'build'} 12:56:12 INFO - ##### 12:56:12 INFO - ##### Running clobber step. 12:56:12 INFO - ##### 12:56:12 INFO - Running pre-action listener: _resource_record_pre_action 12:56:12 INFO - Running main action method: clobber 12:56:12 INFO - rmtree: /builds/slave/test-pgo/build 12:56:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:56:13 INFO - Running post-action listener: _resource_record_post_action 12:56:13 INFO - ##### 12:56:13 INFO - ##### Running read-buildbot-config step. 12:56:13 INFO - ##### 12:56:13 INFO - Running pre-action listener: _resource_record_pre_action 12:56:13 INFO - Running main action method: read_buildbot_config 12:56:13 INFO - Using buildbot properties: 12:56:13 INFO - { 12:56:13 INFO - "project": "", 12:56:13 INFO - "product": "firefox", 12:56:13 INFO - "script_repo_revision": "production", 12:56:13 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 12:56:13 INFO - "repository": "", 12:56:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 12:56:13 INFO - "buildid": "20160228103115", 12:56:13 INFO - "pgo_build": "True", 12:56:13 INFO - "basedir": "/builds/slave/test-pgo", 12:56:13 INFO - "buildnumber": 445, 12:56:13 INFO - "slavename": "talos-linux64-ix-026", 12:56:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:56:13 INFO - "platform": "ubuntu64_hw", 12:56:13 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 12:56:13 INFO - "branch": "mozilla-inbound", 12:56:13 INFO - "repo_path": "integration/mozilla-inbound", 12:56:13 INFO - "revision": "26c6132f3effd41c633aed6adca6268510c6e788", 12:56:13 INFO - "stage_platform": "linux64-pgo", 12:56:13 INFO - "builduid": "f02f334716dc4a7896f9246f9cf88084", 12:56:13 INFO - "slavebuilddir": "test" 12:56:13 INFO - } 12:56:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 12:56:13 INFO - Running post-action listener: _resource_record_post_action 12:56:13 INFO - ##### 12:56:13 INFO - ##### Running download-and-extract step. 12:56:13 INFO - ##### 12:56:13 INFO - Running pre-action listener: _resource_record_pre_action 12:56:13 INFO - Running main action method: download_and_extract 12:56:13 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:13 INFO - https://queue.taskcluster.net/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:56:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/test_packages.json 12:56:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/test_packages.json 12:56:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:56:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:56:24 INFO - Downloaded 1448 bytes. 12:56:24 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:56:24 INFO - Using the following test package requirements: 12:56:24 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 12:56:24 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:56:24 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:56:24 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:24 INFO - u'jsshell-linux-x86_64.zip'], 12:56:24 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:56:24 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 12:56:24 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:56:24 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:56:24 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:56:24 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 12:56:24 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 12:56:24 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:56:24 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:56:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:24 INFO - https://queue.taskcluster.net/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:56:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 12:56:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 12:56:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 12:56:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:56:33 INFO - Downloaded 23371823 bytes. 12:56:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:56:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 12:56:34 INFO - Return code: 0 12:56:34 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:34 INFO - https://queue.taskcluster.net/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:56:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 12:56:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 12:56:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 12:56:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:56:36 INFO - Downloaded 23371823 bytes. 12:56:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:56:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 12:56:37 INFO - Return code: 0 12:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:37 INFO - https://queue.taskcluster.net/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 12:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 12:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 12:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:56:38 INFO - Downloaded 10713410 bytes. 12:56:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 12:56:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 12:56:38 INFO - Return code: 0 12:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:38 INFO - https://queue.taskcluster.net/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:56:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 12:56:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 12:56:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 12:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:56:40 INFO - Downloaded 56631179 bytes. 12:56:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 12:56:40 INFO - mkdir: /builds/slave/test-pgo/properties 12:56:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:56:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:56:40 INFO - Contents: 12:56:40 INFO - build_url:https://queue.taskcluster.net/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 12:56:40 INFO - Running post-action listener: _resource_record_post_action 12:56:40 INFO - Running post-action listener: set_extra_try_arguments 12:56:40 INFO - ##### 12:56:40 INFO - ##### Running populate-webroot step. 12:56:40 INFO - ##### 12:56:40 INFO - Running pre-action listener: _resource_record_pre_action 12:56:40 INFO - Running main action method: populate_webroot 12:56:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:56:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:56:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:56:40 INFO - '--tppagecycles', 12:56:40 INFO - '7'], 12:56:40 INFO - 'tests': ['tsvgm']}}, 12:56:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:56:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:56:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:56:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 12:56:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:56:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:56:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:56:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:40 INFO - 'talos_options': ['--e10s'], 12:56:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:56:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:40 INFO - 'tests': ['damp', 'tps']}, 12:56:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:40 INFO - 'talos_options': ['--e10s'], 12:56:40 INFO - 'tests': ['damp', 'tps']}, 12:56:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:56:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:56:40 INFO - 'other': {'tests': ['a11yr', 12:56:40 INFO - 'ts_paint', 12:56:40 INFO - 'tpaint', 12:56:40 INFO - 'sessionrestore', 12:56:40 INFO - 'sessionrestore_no_auto_restore']}, 12:56:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:56:40 INFO - 'tests': ['a11yr', 12:56:40 INFO - 'ts_paint', 12:56:40 INFO - 'tpaint', 12:56:40 INFO - 'sessionrestore', 12:56:40 INFO - 'sessionrestore_no_auto_restore']}, 12:56:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:56:40 INFO - 'tests': ['a11yr', 12:56:40 INFO - 'ts_paint', 12:56:40 INFO - 'tpaint', 12:56:40 INFO - 'sessionrestore', 12:56:40 INFO - 'sessionrestore_no_auto_restore']}, 12:56:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:56:40 INFO - 'tests': ['a11yr', 12:56:40 INFO - 'ts_paint', 12:56:40 INFO - 'tpaint', 12:56:40 INFO - 'sessionrestore', 12:56:40 INFO - 'sessionrestore_no_auto_restore']}, 12:56:40 INFO - 'other_l64': {'tests': ['a11yr', 12:56:40 INFO - 'ts_paint', 12:56:40 INFO - 'tpaint', 12:56:40 INFO - 'sessionrestore', 12:56:40 INFO - 'sessionrestore_no_auto_restore']}, 12:56:40 INFO - 'other_nol64': {'tests': ['a11yr', 12:56:40 INFO - 'ts_paint', 12:56:40 INFO - 'tpaint', 12:56:40 INFO - 'sessionrestore', 12:56:40 INFO - 'sessionrestore_no_auto_restore']}, 12:56:40 INFO - 'svgr': {'tests': ['tsvgx', 12:56:40 INFO - 'tsvgr_opacity', 12:56:40 INFO - 'tart', 12:56:40 INFO - 'tscrollx', 12:56:40 INFO - 'cart']}, 12:56:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:56:40 INFO - 'tests': ['tsvgx', 12:56:40 INFO - 'tsvgr_opacity', 12:56:40 INFO - 'tart', 12:56:40 INFO - 'tscrollx', 12:56:40 INFO - 'cart']}, 12:56:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:40 INFO - 'tests': ['tp5o']}, 12:56:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:40 INFO - 'talos_options': ['--e10s'], 12:56:40 INFO - 'tests': ['tp5o']}, 12:56:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:40 INFO - 'talos_options': ['--xperf_path', 12:56:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:56:40 INFO - 'tests': ['tp5n']}, 12:56:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:56:40 INFO - 'talos_options': ['--e10s', 12:56:40 INFO - '--xperf_path', 12:56:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:56:40 INFO - 'tests': ['tp5n']}}, 12:56:40 INFO - 'talos.zip': {'path': '', 12:56:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:56:40 INFO - Running post-action listener: _resource_record_post_action 12:56:40 INFO - ##### 12:56:40 INFO - ##### Running create-virtualenv step. 12:56:40 INFO - ##### 12:56:40 INFO - Running pre-action listener: _resource_record_pre_action 12:56:40 INFO - Running main action method: create_virtualenv 12:56:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:56:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 12:56:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:56:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:56:40 INFO - Using real prefix '/usr' 12:56:40 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:56:41 INFO - Installing distribute.............................................................................................................................................................................................done. 12:56:43 INFO - Installing pip.................done. 12:56:43 INFO - Return code: 0 12:56:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:43 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 0x7f573c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b798c0>, '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 0x1b7a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ac50>, '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': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', '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:56:43 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:56:43 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:56:43 INFO - Using env: {'DISPLAY': ':0', 12:56:43 INFO - 'HOME': '/home/cltbld', 12:56:43 INFO - 'LANG': 'en_US.UTF-8', 12:56:43 INFO - 'LANGUAGE': 'en_US:en', 12:56:43 INFO - 'LOGNAME': 'cltbld', 12:56:43 INFO - 'MAIL': '/var/mail/cltbld', 12:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:43 INFO - 'MOZ_NO_REMOTE': '1', 12:56:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:43 INFO - 'NO_EM_RESTART': '1', 12:56:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:43 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:43 INFO - 'SHELL': '/bin/bash', 12:56:43 INFO - 'SHLVL': '1', 12:56:43 INFO - 'TERM': 'linux', 12:56:43 INFO - 'TMOUT': '86400', 12:56:43 INFO - 'USER': 'cltbld', 12:56:43 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', 12:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:43 INFO - '_': '/tools/buildbot/bin/python'} 12:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:44 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:56:44 INFO - Cleaning up... 12:56:44 INFO - Return code: 0 12:56:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f573c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b798c0>, '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 0x1b7a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ac50>, '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': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', '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:56:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 12:56:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:56:44 INFO - Using env: {'DISPLAY': ':0', 12:56:44 INFO - 'HOME': '/home/cltbld', 12:56:44 INFO - 'LANG': 'en_US.UTF-8', 12:56:44 INFO - 'LANGUAGE': 'en_US:en', 12:56:44 INFO - 'LOGNAME': 'cltbld', 12:56:44 INFO - 'MAIL': '/var/mail/cltbld', 12:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:44 INFO - 'MOZ_NO_REMOTE': '1', 12:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:44 INFO - 'NO_EM_RESTART': '1', 12:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:44 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:44 INFO - 'SHELL': '/bin/bash', 12:56:44 INFO - 'SHLVL': '1', 12:56:44 INFO - 'TERM': 'linux', 12:56:44 INFO - 'TMOUT': '86400', 12:56:44 INFO - 'USER': 'cltbld', 12:56:44 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', 12:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:44 INFO - '_': '/tools/buildbot/bin/python'} 12:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:44 INFO - Downloading/unpacking psutil>=0.7.1 12:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:56:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:56:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:56:46 INFO - Installing collected packages: psutil 12:56:46 INFO - Running setup.py install for psutil 12:56:46 INFO - building 'psutil._psutil_linux' extension 12:56:46 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:56:48 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:56:48 INFO - building 'psutil._psutil_posix' extension 12:56:48 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:56:48 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:56:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:56:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:56:48 INFO - Successfully installed psutil 12:56:48 INFO - Cleaning up... 12:56:49 INFO - Return code: 0 12:56:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:49 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 0x7f573c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b798c0>, '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 0x1b7a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ac50>, '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': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', '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:56:49 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:56:49 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:56:49 INFO - Using env: {'DISPLAY': ':0', 12:56:49 INFO - 'HOME': '/home/cltbld', 12:56:49 INFO - 'LANG': 'en_US.UTF-8', 12:56:49 INFO - 'LANGUAGE': 'en_US:en', 12:56:49 INFO - 'LOGNAME': 'cltbld', 12:56:49 INFO - 'MAIL': '/var/mail/cltbld', 12:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:49 INFO - 'MOZ_NO_REMOTE': '1', 12:56:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:49 INFO - 'NO_EM_RESTART': '1', 12:56:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:49 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:49 INFO - 'SHELL': '/bin/bash', 12:56:49 INFO - 'SHLVL': '1', 12:56:49 INFO - 'TERM': 'linux', 12:56:49 INFO - 'TMOUT': '86400', 12:56:49 INFO - 'USER': 'cltbld', 12:56:49 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', 12:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:49 INFO - '_': '/tools/buildbot/bin/python'} 12:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:56:49 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:56:49 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:56:49 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:56:49 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:56:49 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:56:49 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:56:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:56:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:56:51 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:56:51 INFO - Installing collected packages: mozsystemmonitor 12:56:51 INFO - Running setup.py install for mozsystemmonitor 12:56:51 INFO - Successfully installed mozsystemmonitor 12:56:51 INFO - Cleaning up... 12:56:51 INFO - Return code: 0 12:56:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:51 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 0x7f573c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b798c0>, '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 0x1b7a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ac50>, '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': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', '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:56:51 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:56:51 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:56:51 INFO - Using env: {'DISPLAY': ':0', 12:56:51 INFO - 'HOME': '/home/cltbld', 12:56:51 INFO - 'LANG': 'en_US.UTF-8', 12:56:51 INFO - 'LANGUAGE': 'en_US:en', 12:56:51 INFO - 'LOGNAME': 'cltbld', 12:56:51 INFO - 'MAIL': '/var/mail/cltbld', 12:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:51 INFO - 'MOZ_NO_REMOTE': '1', 12:56:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:51 INFO - 'NO_EM_RESTART': '1', 12:56:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:51 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:51 INFO - 'SHELL': '/bin/bash', 12:56:51 INFO - 'SHLVL': '1', 12:56:51 INFO - 'TERM': 'linux', 12:56:51 INFO - 'TMOUT': '86400', 12:56:51 INFO - 'USER': 'cltbld', 12:56:51 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', 12:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:51 INFO - '_': '/tools/buildbot/bin/python'} 12:56:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:51 INFO - Downloading/unpacking blobuploader==1.2.4 12:56:51 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:56:51 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:56:51 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:56:51 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:56:51 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:56:51 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:56:53 INFO - Downloading blobuploader-1.2.4.tar.gz 12:56:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:56:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:56:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:56:53 INFO - Downloading docopt-0.6.1.tar.gz 12:56:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:56:54 INFO - Installing collected packages: blobuploader, requests, docopt 12:56:54 INFO - Running setup.py install for blobuploader 12:56:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:56:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:56:54 INFO - Running setup.py install for requests 12:56:54 INFO - Running setup.py install for docopt 12:56:54 INFO - Successfully installed blobuploader requests docopt 12:56:54 INFO - Cleaning up... 12:56:54 INFO - Return code: 0 12:56:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:54 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 0x7f573c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b798c0>, '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 0x1b7a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ac50>, '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': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', '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:56:54 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:56:54 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:56:54 INFO - Using env: {'DISPLAY': ':0', 12:56:54 INFO - 'HOME': '/home/cltbld', 12:56:54 INFO - 'LANG': 'en_US.UTF-8', 12:56:54 INFO - 'LANGUAGE': 'en_US:en', 12:56:54 INFO - 'LOGNAME': 'cltbld', 12:56:54 INFO - 'MAIL': '/var/mail/cltbld', 12:56:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:54 INFO - 'MOZ_NO_REMOTE': '1', 12:56:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:54 INFO - 'NO_EM_RESTART': '1', 12:56:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:54 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:54 INFO - 'SHELL': '/bin/bash', 12:56:54 INFO - 'SHLVL': '1', 12:56:54 INFO - 'TERM': 'linux', 12:56:54 INFO - 'TMOUT': '86400', 12:56:54 INFO - 'USER': 'cltbld', 12:56:54 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', 12:56:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:54 INFO - '_': '/tools/buildbot/bin/python'} 12:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:56:54 INFO - Running setup.py (path:/tmp/pip-HOfzQj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:56:54 INFO - Running setup.py (path:/tmp/pip-rxt8hz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:56:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:56:54 INFO - Running setup.py (path:/tmp/pip-idcEIu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:56:55 INFO - Running setup.py (path:/tmp/pip-7FtHSk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:56:55 INFO - Running setup.py (path:/tmp/pip-qMK7yC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:56:55 INFO - Running setup.py (path:/tmp/pip-330cnT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:56:55 INFO - Running setup.py (path:/tmp/pip-kGfdQd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:56:55 INFO - Running setup.py (path:/tmp/pip-fAYIUf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:56:55 INFO - Running setup.py (path:/tmp/pip-9xz4SD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:56:55 INFO - Running setup.py (path:/tmp/pip-1PhxE1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:56:55 INFO - Running setup.py (path:/tmp/pip-ojfqnc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:56:55 INFO - Running setup.py (path:/tmp/pip-os18Ok-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:56:55 INFO - Running setup.py (path:/tmp/pip-1Cdll3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:56:55 INFO - Running setup.py (path:/tmp/pip-ibf5En-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:56:55 INFO - Running setup.py (path:/tmp/pip-bUXfVr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:56:55 INFO - Running setup.py (path:/tmp/pip-RyOg4h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:56:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:56:55 INFO - Running setup.py (path:/tmp/pip-2ylSq6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:56:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:56:56 INFO - Running setup.py install for manifestparser 12:56:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:56:56 INFO - Running setup.py install for mozcrash 12:56:56 INFO - Running setup.py install for mozdebug 12:56:56 INFO - Running setup.py install for mozdevice 12:56:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:56:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:56:56 INFO - Running setup.py install for mozfile 12:56:56 INFO - Running setup.py install for mozhttpd 12:56:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:56:56 INFO - Running setup.py install for mozinfo 12:56:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:56:56 INFO - Running setup.py install for mozInstall 12:56:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:56:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:56:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:56:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:56:56 INFO - Running setup.py install for mozleak 12:56:56 INFO - Running setup.py install for mozlog 12:56:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:56:57 INFO - Running setup.py install for moznetwork 12:56:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:56:57 INFO - Running setup.py install for mozprocess 12:56:57 INFO - Running setup.py install for mozprofile 12:56:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:56:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:56:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:56:57 INFO - Running setup.py install for mozrunner 12:56:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:56:57 INFO - Running setup.py install for mozscreenshot 12:56:57 INFO - Running setup.py install for moztest 12:56:57 INFO - Running setup.py install for mozversion 12:56:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:56:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:56:57 INFO - Cleaning up... 12:56:57 INFO - Return code: 0 12:56:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:56:57 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 0x7f573c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b798c0>, '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 0x1b7a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ac50>, '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': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', '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:56:57 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:56:57 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:56:57 INFO - Using env: {'DISPLAY': ':0', 12:56:57 INFO - 'HOME': '/home/cltbld', 12:56:57 INFO - 'LANG': 'en_US.UTF-8', 12:56:57 INFO - 'LANGUAGE': 'en_US:en', 12:56:57 INFO - 'LOGNAME': 'cltbld', 12:56:57 INFO - 'MAIL': '/var/mail/cltbld', 12:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:56:57 INFO - 'MOZ_NO_REMOTE': '1', 12:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:56:57 INFO - 'NO_EM_RESTART': '1', 12:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:56:57 INFO - 'PWD': '/builds/slave/test-pgo', 12:56:57 INFO - 'SHELL': '/bin/bash', 12:56:57 INFO - 'SHLVL': '1', 12:56:57 INFO - 'TERM': 'linux', 12:56:57 INFO - 'TMOUT': '86400', 12:56:57 INFO - 'USER': 'cltbld', 12:56:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', 12:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:56:57 INFO - '_': '/tools/buildbot/bin/python'} 12:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:56:58 INFO - Running setup.py (path:/tmp/pip-xHhzAP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:56:58 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:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:56:58 INFO - Running setup.py (path:/tmp/pip-fMTCAz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:56:58 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:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:56:58 INFO - Running setup.py (path:/tmp/pip-qrlrSM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:56:58 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:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:56:58 INFO - Running setup.py (path:/tmp/pip-v_tjNZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:56:58 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:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:56:58 INFO - Running setup.py (path:/tmp/pip-hsK_Ro-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:56:58 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:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:56:58 INFO - Running setup.py (path:/tmp/pip-qdt7rL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:56:58 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:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:56:58 INFO - Running setup.py (path:/tmp/pip-2kmaQe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:56:58 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:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:56:58 INFO - Running setup.py (path:/tmp/pip-J9Y3pj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:56:58 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:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:56:58 INFO - Running setup.py (path:/tmp/pip-dhN04E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:56:58 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:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:56:58 INFO - Running setup.py (path:/tmp/pip-VEwX6K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:56:58 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:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:56:58 INFO - Running setup.py (path:/tmp/pip-DKB4cI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:56:58 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:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:56:58 INFO - Running setup.py (path:/tmp/pip-2Jh_gD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:56:58 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:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:56:58 INFO - Running setup.py (path:/tmp/pip-20LcCv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:56:58 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:56:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:56:58 INFO - Running setup.py (path:/tmp/pip-XqGQjc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:56:59 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:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:56:59 INFO - Running setup.py (path:/tmp/pip-tUQkBU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:56:59 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:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:56:59 INFO - Running setup.py (path:/tmp/pip-OmWwaM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:56:59 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:56:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:56:59 INFO - Running setup.py (path:/tmp/pip-Lr5gkE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:56:59 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:56:59 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:56:59 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:56:59 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:56:59 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:56:59 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:56:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:56:59 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:56:59 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:56:59 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:56:59 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:56:59 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:56:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:01 INFO - Downloading blessings-1.6.tar.gz 12:57:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:57:01 INFO - Installing collected packages: blessings 12:57:01 INFO - Running setup.py install for blessings 12:57:01 INFO - Successfully installed blessings 12:57:01 INFO - Cleaning up... 12:57:01 INFO - Return code: 0 12:57:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:57:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:57:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:57:01 INFO - Reading from file tmpfile_stdout 12:57:01 INFO - Current package versions: 12:57:01 INFO - argparse == 1.2.1 12:57:01 INFO - blessings == 1.6 12:57:01 INFO - blobuploader == 1.2.4 12:57:01 INFO - docopt == 0.6.1 12:57:01 INFO - manifestparser == 1.1 12:57:01 INFO - mozInstall == 1.12 12:57:01 INFO - mozcrash == 0.16 12:57:01 INFO - mozdebug == 0.1 12:57:01 INFO - mozdevice == 0.48 12:57:01 INFO - mozfile == 1.2 12:57:01 INFO - mozhttpd == 0.7 12:57:01 INFO - mozinfo == 0.9 12:57:01 INFO - mozleak == 0.1 12:57:01 INFO - mozlog == 3.1 12:57:01 INFO - moznetwork == 0.27 12:57:01 INFO - mozprocess == 0.22 12:57:01 INFO - mozprofile == 0.28 12:57:01 INFO - mozrunner == 6.11 12:57:01 INFO - mozscreenshot == 0.1 12:57:01 INFO - mozsystemmonitor == 0.0 12:57:01 INFO - moztest == 0.7 12:57:01 INFO - mozversion == 1.4 12:57:01 INFO - psutil == 3.1.1 12:57:01 INFO - requests == 1.2.3 12:57:01 INFO - wsgiref == 0.1.2 12:57:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-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 0x7f573c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b798c0>, '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 0x1b7a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ac50>, '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': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:57:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 12:57:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:57:01 INFO - Using env: {'DISPLAY': ':0', 12:57:01 INFO - 'HOME': '/home/cltbld', 12:57:01 INFO - 'LANG': 'en_US.UTF-8', 12:57:01 INFO - 'LANGUAGE': 'en_US:en', 12:57:01 INFO - 'LOGNAME': 'cltbld', 12:57:01 INFO - 'MAIL': '/var/mail/cltbld', 12:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:01 INFO - 'MOZ_NO_REMOTE': '1', 12:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:01 INFO - 'NO_EM_RESTART': '1', 12:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:01 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:01 INFO - 'SHELL': '/bin/bash', 12:57:01 INFO - 'SHLVL': '1', 12:57:01 INFO - 'TERM': 'linux', 12:57:01 INFO - 'TMOUT': '86400', 12:57:01 INFO - 'USER': 'cltbld', 12:57:01 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', 12:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:01 INFO - '_': '/tools/buildbot/bin/python'} 12:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 12:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 12:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 12:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 12:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 12:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 12:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 12:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 12:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 12:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 12:57:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 12:57:01 INFO - Cleaning up... 12:57:01 INFO - Return code: 0 12:57:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:01 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f573c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b798c0>, '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 0x1b7a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ac50>, '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': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:57:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 12:57:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:57:01 INFO - Using env: {'DISPLAY': ':0', 12:57:01 INFO - 'HOME': '/home/cltbld', 12:57:01 INFO - 'LANG': 'en_US.UTF-8', 12:57:01 INFO - 'LANGUAGE': 'en_US:en', 12:57:01 INFO - 'LOGNAME': 'cltbld', 12:57:01 INFO - 'MAIL': '/var/mail/cltbld', 12:57:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:01 INFO - 'MOZ_NO_REMOTE': '1', 12:57:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:01 INFO - 'NO_EM_RESTART': '1', 12:57:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:01 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:01 INFO - 'SHELL': '/bin/bash', 12:57:01 INFO - 'SHLVL': '1', 12:57:01 INFO - 'TERM': 'linux', 12:57:01 INFO - 'TMOUT': '86400', 12:57:01 INFO - 'USER': 'cltbld', 12:57:01 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', 12:57:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:01 INFO - '_': '/tools/buildbot/bin/python'} 12:57:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:01 INFO - Downloading/unpacking jsonschema 12:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:57:03 INFO - Downloading/unpacking functools32 (from jsonschema) 12:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:03 INFO - Downloading functools32-3.2.3-2.tar.gz 12:57:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:57:04 INFO - warning: no files found matching '*.txt' 12:57:04 INFO - no previously-included directories found matching 'build' 12:57:04 INFO - no previously-included directories found matching 'dist' 12:57:04 INFO - no previously-included directories found matching '.git*' 12:57:04 INFO - Installing collected packages: jsonschema, functools32 12:57:04 INFO - Running setup.py install for functools32 12:57:04 INFO - warning: no files found matching '*.txt' 12:57:04 INFO - no previously-included directories found matching 'build' 12:57:04 INFO - no previously-included directories found matching 'dist' 12:57:04 INFO - no previously-included directories found matching '.git*' 12:57:04 INFO - Successfully installed jsonschema functools32 12:57:04 INFO - Cleaning up... 12:57:04 INFO - Return code: 0 12:57:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:57:04 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f573c9f1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a1d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aea670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b798c0>, '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 0x1b7a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ac50>, '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': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:57:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 12:57:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:57:04 INFO - Using env: {'DISPLAY': ':0', 12:57:04 INFO - 'HOME': '/home/cltbld', 12:57:04 INFO - 'LANG': 'en_US.UTF-8', 12:57:04 INFO - 'LANGUAGE': 'en_US:en', 12:57:04 INFO - 'LOGNAME': 'cltbld', 12:57:04 INFO - 'MAIL': '/var/mail/cltbld', 12:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:04 INFO - 'MOZ_NO_REMOTE': '1', 12:57:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:04 INFO - 'NO_EM_RESTART': '1', 12:57:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:04 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:04 INFO - 'SHELL': '/bin/bash', 12:57:04 INFO - 'SHLVL': '1', 12:57:04 INFO - 'TERM': 'linux', 12:57:04 INFO - 'TMOUT': '86400', 12:57:04 INFO - 'USER': 'cltbld', 12:57:04 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', 12:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:04 INFO - '_': '/tools/buildbot/bin/python'} 12:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:57:04 INFO - Downloading/unpacking flake8 12:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:57:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:57:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:57:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:57:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:57:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:57:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:57:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:57:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:57:06 INFO - no previously-included directories found matching 'docs/_build' 12:57:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:57:07 INFO - Running setup.py install for pep8 12:57:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:57:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:57:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:57:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:57:07 INFO - no previously-included directories found matching 'docs/_build' 12:57:07 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:57:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:57:07 INFO - Cleaning up... 12:57:07 INFO - Return code: 0 12:57:07 INFO - Running post-action listener: _resource_record_post_action 12:57:07 INFO - Running post-action listener: _start_resource_monitoring 12:57:07 INFO - Starting resource monitoring. 12:57:07 INFO - ##### 12:57:07 INFO - ##### Running install step. 12:57:07 INFO - ##### 12:57:07 INFO - Running pre-action listener: _resource_record_pre_action 12:57:07 INFO - Running main action method: install 12:57:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:57:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:57:07 INFO - Reading from file tmpfile_stdout 12:57:07 INFO - Detecting whether we're running mozinstall >=1.0... 12:57:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:57:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:57:07 INFO - Reading from file tmpfile_stdout 12:57:07 INFO - Output received: 12:57:07 INFO - Usage: mozinstall [options] installer 12:57:07 INFO - Options: 12:57:07 INFO - -h, --help show this help message and exit 12:57:07 INFO - -d DEST, --destination=DEST 12:57:07 INFO - Directory to install application into. [default: 12:57:07 INFO - "/builds/slave/test-pgo"] 12:57:07 INFO - --app=APP Application being installed. [default: firefox] 12:57:07 INFO - mkdir: /builds/slave/test-pgo/build/application 12:57:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 12:57:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 12:57:23 INFO - Reading from file tmpfile_stdout 12:57:23 INFO - Output received: 12:57:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:57:23 INFO - Running post-action listener: _resource_record_post_action 12:57:23 INFO - ##### 12:57:23 INFO - ##### Running run-tests step. 12:57:23 INFO - ##### 12:57:23 INFO - Running pre-action listener: _resource_record_pre_action 12:57:23 INFO - Running main action method: run_tests 12:57:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:57:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:57:23 INFO - Python 2.7.3 12:57:23 INFO - Return code: 0 12:57:23 INFO - grabbing minidump binary from tooltool 12:57: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:57:23 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 0x1b798c0>, '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 0x1b7a7c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b7ac50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:57:23 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 12:57:23 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:57:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:57:24 INFO - Return code: 0 12:57:24 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:57:24 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:57:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:57:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:57:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:57:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:57:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:57:25 INFO - Return code: 0 12:57:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 12:57:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:57:25 INFO - Using env: {'DISPLAY': ':0', 12:57:25 INFO - 'HOME': '/home/cltbld', 12:57:25 INFO - 'LANG': 'en_US.UTF-8', 12:57:25 INFO - 'LANGUAGE': 'en_US:en', 12:57:25 INFO - 'LOGNAME': 'cltbld', 12:57:25 INFO - 'MAIL': '/var/mail/cltbld', 12:57:25 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:57:25 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:57:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:57:25 INFO - 'MOZ_NO_REMOTE': '1', 12:57:25 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:57:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:57:25 INFO - 'NO_EM_RESTART': '1', 12:57:25 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:57:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:57:25 INFO - 'PWD': '/builds/slave/test-pgo', 12:57:25 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:57:25 INFO - 'SHELL': '/bin/bash', 12:57:25 INFO - 'SHLVL': '1', 12:57:25 INFO - 'TERM': 'linux', 12:57:25 INFO - 'TMOUT': '86400', 12:57:25 INFO - 'USER': 'cltbld', 12:57:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747', 12:57:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:57:25 INFO - '_': '/tools/buildbot/bin/python'} 12:57:25 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:57:25 INFO - mozversion application_buildid: 20160228103115 12:57:25 INFO - mozversion application_changeset: 26c6132f3effd41c633aed6adca6268510c6e788 12:57:25 INFO - mozversion application_display_name: Nightly 12:57:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:57:25 INFO - mozversion application_name: Firefox 12:57:25 INFO - mozversion application_remotingname: firefox 12:57:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:57:25 INFO - mozversion application_vendor: Mozilla 12:57:25 INFO - mozversion application_version: 47.0a1 12:57:25 INFO - mozversion platform_buildid: 20160228103115 12:57:25 INFO - mozversion platform_changeset: 26c6132f3effd41c633aed6adca6268510c6e788 12:57:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:57:25 INFO - mozversion platform_version: 47.0a1 12:57:25 INFO - using testdate: 1456693045 12:57:25 INFO - actual date: 1456693045 12:57:25 INFO - starting webserver on 'localhost:56046' 12:57:25 INFO - SUITE-START | Running 2 tests 12:57:25 INFO - TEST-START | dromaeo_css 12:57:25 INFO - operating with platform_type : linux_ 12:57:25 INFO - Initialising browser for dromaeo_css test... 12:57:25 INFO - TEST-INFO | started process 3350 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMPiITD/profile http://localhost:56046/getInfo.html) 12:57:31 INFO - PROCESS | 3350 | 12:57:31 INFO - PROCESS | 3350 | (process:3436): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:57:32 INFO - PROCESS | 3350 | __metrics Screen width/height:1600/1200 12:57:32 INFO - PROCESS | 3350 | colorDepth:24 12:57:32 INFO - PROCESS | 3350 | Browser inner width/height: 1024/697 12:57:32 INFO - PROCESS | 3350 | __metrics 12:57:32 ERROR - PROCESS | 3350 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 12:57:32 INFO - PROCESS | 3350 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 12:57:32 INFO - PROCESS | 3350 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 12:57:32 INFO - PROCESS | 3350 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 12:57:32 INFO - PROCESS | 3350 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 12:57:32 INFO - PROCESS | 3350 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 12:57:32 INFO - PROCESS | 3350 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 12:57:32 INFO - PROCESS | 3350 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 12:57:32 INFO - PROCESS | 3350 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 12:57:32 INFO - PROCESS | 3350 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 12:57:33 INFO - TEST-INFO | 3350: exit 0 12:57:33 INFO - Browser initialized. 12:57:33 INFO - Running cycle 1/1 for dromaeo_css test... 12:57:33 INFO - TEST-INFO | started process 3487 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMPiITD/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:57:35 INFO - PROCESS | 3487 | 12:57:35 INFO - PROCESS | 3487 | (process:3544): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 12:57:45 INFO - PROCESS | 3487 | RSS: Main: 161103872 12:57:45 INFO - PROCESS | 3487 | 12:58:35 INFO - PROCESS | 3487 | 1456693115116 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:00:42 INFO - PROCESS | 3487 | Cycle 1(1): loaded http://localhost:56046/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56046/tests/dromaeo/cssquery-ext.html) 13:00:43 INFO - PROCESS | 3487 | RSS: Main: 169598976 13:00:43 INFO - PROCESS | 3487 | 13:03:45 INFO - PROCESS | 3487 | Cycle 1(1): loaded http://localhost:56046/tests/dromaeo/cssquery-ext.html (next: http://localhost:56046/tests/dromaeo/cssquery-jquery.html) 13:03:46 INFO - PROCESS | 3487 | RSS: Main: 165535744 13:03:46 INFO - PROCESS | 3487 | 13:06:48 INFO - PROCESS | 3487 | Cycle 1(1): loaded http://localhost:56046/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56046/tests/dromaeo/cssquery-mootools.html) 13:06:48 INFO - PROCESS | 3487 | RSS: Main: 167297024 13:06:48 INFO - PROCESS | 3487 | 13:09:50 INFO - PROCESS | 3487 | Cycle 1(1): loaded http://localhost:56046/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56046/tests/dromaeo/cssquery-prototype.html) 13:09:51 INFO - PROCESS | 3487 | RSS: Main: 164556800 13:09:51 INFO - PROCESS | 3487 | 13:12:53 INFO - PROCESS | 3487 | Cycle 1(1): loaded http://localhost:56046/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56046/tests/dromaeo/cssquery-yui.html) 13:12:54 INFO - PROCESS | 3487 | RSS: Main: 164683776 13:12:54 INFO - PROCESS | 3487 | 13:15:56 INFO - PROCESS | 3487 | Cycle 1(1): loaded http://localhost:56046/tests/dromaeo/cssquery-yui.html (next: http://localhost:56046/tests/dromaeo/cssquery-dojo.html) 13:15:56 INFO - PROCESS | 3487 | RSS: Main: 168099840 13:15:56 INFO - PROCESS | 3487 | 13:15:56 INFO - PROCESS | 3487 | __start_tp_report 13:15:56 INFO - PROCESS | 3487 | _x_x_mozilla_page_load 13:15:56 INFO - PROCESS | 3487 | _x_x_mozilla_page_load_details 13:15:56 INFO - PROCESS | 3487 | |i|pagename|runs| 13:15:56 INFO - PROCESS | 3487 | |0;dojo.html;3117.3765246950607;3199.8400079995995;3222.5166225066223;3243.0270918724386;3250.0737289872377;4968.0809050325715;5192.402873669529;5221.68669879807;5226.634135610509;5285.973570132144;5111.233315002752;5151.227315902607;5183.092958732225;5214.06146893559;5257.211418287249;44.672980915749335;4658.90682186356;4784.880377990543;4862.708237505743;4880.8047678092835;4708.811647534095;4755.90488190236;4767.284907263921;4771.928421073687;4838.274258861182;4750.714957102585;4770.785314660866;4782.354382158399;4788.138135135691;4804.111239420683;4642.326862604938;4737.194676904935;4858.514148585148;4862.416510018785;4900.58345040672;4701.78841952113;4754.7147171169845;4762.28565715142;4767.189577771787;4797.688150270221;4846.248831431134;4865.6107511399005;4890.877728056791;4902.4852390498845;4919.065377578248;5429.701366424845;5461.9453805462235;5480.451954804527;5498.532624726903;5554.472325129106;5579.442055794429;5597.6641401515635;5603.3836278009385;5606.943930560683;5645.830625081254;5225.660332078441;5234.555062819665;5236.136037553799;5256.211568264791;5288.365396152486;5614.719264036782;5677.148427735872;5687.232223649754;5701.857453563694;5736.541076713853;5409.350877894599;5452.672839629635;5452.890942181134;5461.617686761889;5492.038893193675;5477.698726569997;5521.2270282160525;5528.336599607992;5534.1975413565615;5569.972150139223;5422.484863937999;5497.47773961473;5534.501894829405;5545.445455454503;5595.63628364155;5485.177223416519;5532.723363831792;5549.972250138723;5577.776888924479;5624.55003599711;4265.722728022731;4271.10306835568;4308.289132293199;4322.113966636832;4323.546027667113;3875.379939209713;3889.591592882763;3890.5525864525944;3898.9805050975133;3926.6269704378037;5251.054810134213;5275.762590683428;5282.550983166474;5291.841244762663;5294.97352513235;5498.505134537911;5591.217229587861;5592.692401917852;5594.552435805126;5642.210090587321;5228.764705588258;5241.344831896013;5241.344831896013;5271.868203294948;5291;4824.638152138604;4831.4202295724735;4844.781984810692;4856.708597484162;4896.853094407174;5899.557533185029;5905.645661260338;5906.497947674496;5934.8813023739285;5935.139404786368;5485.6434331768305;5516.503514683698;5549.861253468614;5558.555315574825;5592.69240191777;5835.037218858841;5840.269966254218;5858.091995740497;5858.2677165354335;5863.061910094364;5474.124140137559;5516.972415138059;5521.3926468087675;5534.723263836872;5548.69482178484;5578;5696.914546281892;5703.600747947604;5705.857353566194;5745.3105627324985;5484.232207490874;5492.038893193755;5495.175723641326;5503.944960550343;5505.3393592767525;5392.892142157057;5482.17767334903;5482.39693633708;5485.862853428696;5494.1758736189895;5267.710275934707;5329.760160792696;5386.35363756336;5392.299001129828;5423.484768946943;5395.190721391823;5531.612787104864;5542.445755424586;5561.888762224814;5571.331440227199;5305.708186049805;5333.333333333333;5402.405735369028;5407.07832077076;5466.043442397644 13:15:56 INFO - PROCESS | 3487 | |1;ext.html;528.2287859724802;541.3530830657363;574.9827505174843;583.1486030395622;583.7285662167092;28362.290942726417;37437;37537.249255014955;37720;37851;39582.20835583287;40270.7986460068;40287.79856100723;40319;40401.19197616046;8479.915200847974;8632.525211113387;8761.299096072331;8762.561871906379;8800.603972821207;8510.361722870779;8716.869246961302;8757.474551526897;8757.956210218972;8976.775580610472;8878.644854205824;8886.511241881693;8942.284617230605;8963.058878817728;8974.551272436385;8766.079561646064;8805.031446540908;8862;8874.29005679544;8934.374593778439;8629.56852157396;8752.168543988311;8777.868331975025;8801.515916624583;8835.293176545862;39989.40015899764;40434.595654043376;40521.79739101315;40746.18507629831;40777;3421.5038819371302;3566.857325706969;3665.981670091659;4101.794910254505;4117.876463706094;26380.0766973155;27025.45949081027;27204.72795272042;27215.319617009733;27234;3694.1503454205413;3769.8492060317553;3793.165503589206;3798.962010379916;3994.840206391741;212837;215062;215393;215849;215900.99999999843;55851;56002;56219;56259.43740562624;56456.15315770267;63899.361006390274;63966;64032;64094;64287;15246.695066098617;15338.079715217124;15404.383824647113;15423.691526169638;15451.922740386452;10730.731731706614;10794.028537431668;10811.6215932442;10820.134389248999;10859.2398532102;20621.793782062286;20715.4821129473;20724.171033158807;20728.170873165207;21036;8059.274665280153;8298.336133109337;8315.210055044761;8322.334213262924;8364;943.3160958305174;968.6803354892868;1001.3691374434205;1037.4968140451874;1079.9298045627008;28952.855235723688;28980.20461527773;28996;29303;29333.413331733245;1029.351508549609;1063.4204358624413;1070.2294348069377;1082.6535508637319;1089.9509522071526;14632.341544630517;14976.62558436026;15045.322960466587;15245.923770381078;15317.31072101758;289088;290945;293146;293195;294984;50325.49674503281;52050.73974630103;52132.739336303835;52140.739296303276;52162;1320.0627554436458;1342.61735405409;1360.1023324605712;1369.2127026959338;1371.3417559571262;26885.327866803487;27889.44221115607;28386.85806570954;28408;28539.857300713364;37203;37273.627263727016;37312.44031339586;37377.62622373742;37596.436053458674;191743;194126;194763;195030;196854;27585.586216207175;27951.44097118087;28232.43535129327;28440.28899277452;28670.42659146847;41816.790916045225;42168.1566368677;42489.36265955951;42592.5740742601;43010.13979720326;35816.4627530582;35864;35959.82020089883;36010.63989360178;36386;35702;36075.458868116475;36137.81931090328;36462;36869;34507.30985380329;34820;35499.46750798688;35522.467162993096;35686.64313356833;30809.69190308158;31700.84127205122;31800.204994875312;31839.522407164375;32218.35563288768;24028.39929001719;24915;25100.00698303141;25143;25200.873995629903 13:15:56 INFO - PROCESS | 3487 | |2;jquery.html;346.08633208329996;346.9460792110705;352.5135313267691;353.01156761069035;355.37276706612835;16377.672446551062;17048.82951170488;17142.657146857055;17539.473815785514;17990.370337038174;10024.097831195191;10184.694459166218;10233.641822536212;11544.018758405524;15572.143532105729;4718.90562188756;4953.108440480712;4971.353724015873;4977.104121258172;4993.101241776479;4906.141425250585;4983.825566105187;5180.067587834188;5201.973990130044;5205.271262023301;4894.1679914414635;5132.332796736419;5152.355955505562;5177.456367081459;5183.248428977796;4987.0524600325825;4997.875053123665;4999.450060493343;5015.172496538067;5015.924761128567;4822.734749588772;4836.371271734687;4999.400071991348;5196.58427325813;5221.373435187764;19269.036548172677;19283.42149735496;19327.323543675902;19609.411717648494;19678.114484848214;2099.139352865333;2248.910043598254;2387.713474383068;2446.351716795051;2571.010161087976;8602.139786021347;8844;10169.796604067877;11253.099752019818;13021.934890325489;1823.5988082621934;1827.2142978519232;1838.2187570282576;1911.4743445552444;1943.7570303712037;58528.41471585315;58622.41377586212;59520.404795951916;60253.09620355698;60633.090503642925;9900.306978511579;9916;9989.900100999042;9993.250506212064;10100.898991009995;12062.336571488653;12892.48430062787;12930.288834114213;12942.417591208417;13014.739705205842;7148.92851071493;7302.160251571031;7363.631818409058;7406.777796666109;7426.368758655575;7282.890756638654;7311.8537629248185;7353.963230183922;7379.040724705754;7447.329740323397;4058.7564746115327;4114.506259248909;4136.234796562646;4298.20483210607;4324;1836.6143109946793;1877.6807942649782;1883.5385330594092;1912.8087191281038;1918.414883460558;956.1967946924617;971.708487453761;981.0679854138597;1008.8738907636546;1010.4190090697878;16186.19069046543;16265.674686506203;16274.26765795542;16559.586010349838;16608.25262863174;956.712986104166;963.8939716631165;986.1322036607739;991.6083147156833;1048.4495639789172;9252.398594091363;9280.02559731232;9361.251099911991;9556.283278753983;9678.370905891095;389475;389866;391434;394004;399948;69931;72851.63574182095;72946;75360.24639753532;75366.62316688382;999.7850462150673;1004.3070281505737;1012.7063151685928;1013.1995723378449;1020.4489575629077;14335.56993290203;14582.626569016766;14683;14745.410183592965;14966.775498367315;22068.117275308807;22351;22474.550508990054;31016;33685.49471757975;40069;41626.58373416227;41632;41645.79177104095;42031.79682031772;7354.485186036926;7555.395568354408;7580.696772129053;7764.534127952341;7847.764567062997;11702.941485292518;12247.75504489923;12358.938205308916;12506.124571279923;12784.61646150617;10376.429296388771;10452.529636166542;10552.947235263775;10636.149108071491;10933;10435.895641043493;10483;10502.78994420092;10533;10633.149348052291;10135.898641013495;10281.9485902573;10339.483025848827;10399.168066554808;10603.89396106029;7378.335949764547;7570.129435114812;7619.390448763975;7624.161342252237;8170.509769413617;9186.269071428087;10026.899731002597;10086.243531735003;10229.539670714985;10306.33008854422 13:15:56 INFO - PROCESS | 3487 | |3;mootools.html;1471.558532440268;1475.129673492639;1665.3838079910436;1765.082157278216;1820.1172431370792;6180.3510631383615;6627;7195.496315257934;7396.593187374692;7410.740624078158;7087.751928682497;7136.464765142609;7144.8928266076055;7194.856102877952;7215.062041934541;2190.375742913274;2219.2676416782424;2225.10995601759;2228.5097278598682;2231.6206244938317;2170.750363708178;2194.473326401668;2200.3508964855328;2222;2239.484918468753;2147.7315335583053;2171.4354267890385;2186.35502526755;2197.28588208832;2241.663750437431;2184.191849015858;2210.1490925993526;2210.53578748463;2213.4908970936613;2215.9778402216093;2217.5897458970144;2249.6850440938283;2256.3343813575034;2258.920937767187;2262.6832243485924;7020.227774944752;7047.753328633525;7053.188883278437;7068.939659051132;7101.89347159793;4455.955440445587;4466.33005049242;4537.659675524316;4548.272276435788;4549.795259213311;2879.294572829649;3039.1946134274435;3044.406340763552;3061.0969763919697;3061.8315992620396;898.6495266845935;902.8374892519344;922.294444749767;926.7312479381039;943.495230051919;9847.950760246225;9851.852222216672;9874.061964113469;9887.555060022316;9927.851082233772;4048.5748996355546;4096.672266218696;4097.467329247179;4114.814833332507;4204.5375008749015;8447.704330348532;8543.957280213559;8564.100769419247;8566.18621230982;8569;4514.70654407469;4517.34498497716;4539.296409056601;4540.318952157203;4546.40896683429;3936.8031598419966;4102.979485102555;4105.651019663362;4114.321137012359;4143.0678097427835;3396.796192228425;3399.456087026064;3449.275652113034;3453.671901169385;3482.7562070655317;1033.0857191385678;1040.193849766437;1041.739565108723;1061.2783307351076;1065.7708592652461;1335.085466455481;1338.6921008168176;1344.3547097393111;1345.0920628575673;1367.5145323410047;6902.137232845895;7066.540674856118;7070.92929070713;7158.0336654550965;7169.318914703095;1116.7543140509074;1132.0660455124555;1137.6075254037344;1142.5030111901349;1151.6372342712018;5446.046941785251;5497.367802702661;5509.393966663663;5510.9448905510435;5511.118221084607;8371.832563348698;8452.1547845215;8830.381873268809;8847.69033083839;8954.86567701485;8963.865542016874;8976.371653984159;9000.459972401677;9022.639094436148;9056.27549796028;6829.658517074126;6861.210960739579;6929;6939;6996.405305548984;6604.339566043357;6683.164604424447;6691.933080669131;6711.832204194934;6761.560498567577;7537.397008239218;7692.307692307719;7693.846123077619;7832.37341012729;7898.091719452336;7426.331630153312;7528.473006889465;7537.434692397982;7570.697172113054;7870.881936771068;6067.696615169312;6537.5096867734155;6554.442872355903;6650.534462587572;6904.965475172592;6912.447004239548;6936.4797640176175;6950.54821436605;6953.6523173842115;6978.616176110363;6333.493320534254;6364.363563643598;6382.712777925098;6452.806415807533;6530.412262896172;6285.5600107992;6285.811425657238;6383.425491705769;6409.519286053658;6440.194975628046;6587.835304117435;6596.175478065242;6625.138731965007;6638.734450621921;6646.202455705153;6073.726682299219;6096.207493025879;6172.876542469216;6176.752929882934;6180.4746596538;6427.871442571029;6432;6467.223933128054;6500.187476565429;6534.4772418205475 13:15:56 INFO - PROCESS | 3487 | |4;prototype.html;306.95856059431986;309.23310190726994;317.85378725786154;319.40909317762146;321.34766424158965;6152.846178845525;6289.9685501572485;6344.58760180588;6395.552311338208;6476.5142614303995;6176.938230617692;6199.07013947908;6234.345393733649;6237.844053898643;6250.718717657705;4519.615832654228;4617.14582802181;4631.421072365954;4639.65202609804;4724.362211101509;4611.631069514431;4619.607333376667;4627.652926030544;4629.699069560468;4641.350210970467;4533.77331133442;4582.816687332519;4598.402207713009;4629.351890735283;4638.9536104638855;4645.094206629708;4645.605123564501;4649.1863923813535;4653.208954477713;4655.115528049693;3967.206558688274;3971.1660551283976;3971.960280397188;3975.7216994810374;3988.541317748467;5942.168096466498;5950.613210141327;5950.702464876739;5952.255968003999;5996.880062398771;5240.082985477527;5341.278927344798;5359.544438722674;5376.569874410038;5383.327084114486;6584;6605.438537724299;6612.702428390734;6613.702383392759;6616.040674102228;4339.479262488521;4344.500382455994;4357.324614684729;4361.6510679145595;4379.189849877751;6869.725210991554;6880.380765731058;6958.130233720785;6963.9651801740665;6968.686409111602;4321.2653848845775;4323.351497275434;4323.913521729548;4325.372820941009;4331.220380331508;4313.870583882489;4353.869383918487;4441.955580444154;4447.3329000650165;4460.487043989918;5303.231031500411;5316.202569614588;5353;5354.330708661418;5362.731863406814;6670.099536562599;6715.731370745213;6721.227058888193;6725.596464212163;6731.562448440835;1571.842815718442;1574.9606259843367;1575.8739300856134;1576.5428025872368;1579.2261791721974;990.9851352229722;1011.6509804117568;1024.5031159887449;1025.015984654725;1038.4859494550246;6367.649779262185;6376.808695739135;6381.1066450696935;6398.232212134573;6402.967985160044;6897.3447522485285;6914.446844252448;6921;6921.307869213139;6946.131733533309;6267.2165979252595;6338.239411270677;6363.204599425072;6393.168888044617;6430.421262086435;3753.6621704046765;3755.8122093895195;3756.417755247941;3758.774473531597;3773.603771603942;7329.413646908234;7331.450141239428;7336.523125996793;7344.742933997284;7349.04462419882;7105.92894071063;7111.862102063645;7127.536710113826;7155.141383033965;7170;7079.327463890922;7333.706651733977;7340.15588207363;7369.742059027908;7395.593242371721;6929.549579277331;6957.895631565631;6966.3730264276455;6966.721331146698;6969.059177011241;6820.829479263058;6856.9314306856295;6870.828229294308;6883.346082122191;6889.242183359726;7288.562686238843;7342.412606991321;7345.714499962592;7375.078115235596;7380.114386273682;4351.129774045267;4403.427554418034;4428.889277768081;4459.821607135808;4468.4637843458995;6929.133858267716;6997.370236678723;7023.859522809413;7024.5434046786795;7038.824029399306;6711.530192886451;6734.124563806674;6738;6738.124043874265;6740.292269311848;6691.397774200345;6725.831854203684;6774.119364482585;6781.559198652072;6784.525083244323;6442.581232219891;6598.736050557924;6615.503837212132;6621.073049773132;6658.866822663616;6778.728850846108;6788.185417749704;6810.31896810315;6818.215905170969;6835.58986460814;6654.968479885625;6656.5340426169705;6658.700358483783;6659.766908158192;6676.632785196666 13:15:56 INFO - PROCESS | 3487 | |5;yui.html;812.9634166462512;816.3346872299076;822.564041058239;826.9609186240565;855.6577369052383;13960.930195349034;13983.440662373492;14045.719085618282;14116.999999999975;14149.999999999987;11748.177627566074;12575.874241257585;12990.28553429561;13029.934850325759;13104.606861794162;814.8044469327364;829.8838162657232;830.767385132164;834.6452757578036;836.6444261189001;828.3662997806653;833.6415341403194;834.5827086456771;835.3275613131427;837.1753822484848;862.5213006781233;867.4751775176022;871.024452613071;871.7515508080198;872.1627237851638;866.2420382165606;866.4801119328447;867.5792240763225;867.895852497698;868.2836659755727;632.6963057732269;638.594492497263;638.8498702804837;639;642.1555654314608;13347.666308342272;13378.39797209128;13397;13411.195328280237;13433.39549720265;13390.129641573267;13483.528076517276;13645.249511276876;13698.863011369858;13703.383347749375;10024.448655323955;10514.21143414247;10563.841542376793;10674;11176.944115279453;3641.1261297288725;3643.198496330803;3665.8900232992787;3674.669279764834;3776.9055773605605;49269.507304926854;50106.999999999636;50712.23931641028;50815.491845081444;50868.23697644538;10311.48442577868;10398.220133490018;10430.322029068086;10546.41994690284;10550.736231594117;18034.27862885496;18041.368552100612;18083.819161808213;18116.275348986157;18121.818781812013;7523.172451030382;7618.923810761821;7621.771346859603;7694.923050769533;7828.178041305581;4210.368444733253;4297.355396690459;4315.331123675835;4355.912881742411;4440.467143942683;3098.7366073883973;3135.1691801672573;3145.9842700786808;3154.794938329047;3168.98415507921;575.9654420734769;584.9122631605293;592.8221533539921;593.1221791748237;604.7460066771879;681.4854784637566;687.3470203306879;697.5709938387956;710.1726488640779;712.3659942651045;8197.46716463428;8880.822383552293;8913.509756963429;9030.819383612292;9075.54622268897;568.8919105369966;569.9458551437607;595.9314678811905;669.7050511483512;714.2607401339588;4055.7769322687536;4121.1345617420075;4212.894677633022;4255.1915136124035;4267.97866010668;56232.718836405555;57138.714306429036;57310.42689573051;57537.71231143901;57787.711061444425;49309;49939;50887.7455612727;51095.7445212779;51189.74405127951;46207.53792462032;46317;47031;47153.29270060952;47318.29022564664;8363.707270245512;8453.535055571756;8457.196566326189;8503.574821259035;8720.302375809793;34339.313213735084;34879;35018;35748.4637730429;35982.8200858994;39126;39350.2129957405;41050.58949410468;43879.561204387544;44174.55825441833;10049.899501004897;10396;10433.530491127765;10606.575736970435;10655.680329590125;11292.548298067984;11313.321200727984;11383.601573944872;11547.4803633835;12019.75960480803;10717.839232411365;10978.945105274423;11003.17476189305;11163.279572824416;11246.1565382595;10453.581856725647;10724.517396717323;10762.569497220024;10773;10795.514201861091;9992.250581206294;10008.549615267184;10029.398236105857;10034;10051.949740251252;8088.595570221583;8360.372972027;8374.371922105745;8378.287845533197;8505.532195729294;8586.367582346447;8613.353998450266;8761.773351730635;8780.273797772588;9125.45247285165 13:15:56 INFO - PROCESS | 3487 | __end_tp_report 13:15:56 INFO - PROCESS | 3487 | __start_cc_report 13:15:56 INFO - PROCESS | 3487 | _x_x_mozilla_cycle_collect,322 13:15:56 INFO - PROCESS | 3487 | __end_cc_report 13:15:56 INFO - PROCESS | 3487 | __startTimestamp1456694156934__endTimestamp 13:15:56 INFO - PROCESS | 3487 | 13:15:56 INFO - PROCESS | 3487 | ------- Summary: start ------- 13:15:56 INFO - PROCESS | 3487 | Number of tests: 6 13:15:56 INFO - PROCESS | 3487 | 13:15:56 INFO - PROCESS | 3487 | [#0] dojo.html Cycles:165 Average:5163.17 Median:5395.19 stddev:690.70 (12.8%) stddev-sans-first:673.91 13:15:56 INFO - PROCESS | 3487 | Values: 3117.4 3199.8 3222.5 3243.0 3250.1 4968.1 5192.4 5221.7 5226.6 5286.0 5111.2 5151.2 5183.1 5214.1 5257.2 44.7 4658.9 4784.9 4862.7 4880.8 4708.8 4755.9 4767.3 4771.9 4838.3 4750.7 4770.8 4782.4 4788.1 4804.1 4642.3 4737.2 4858.5 4862.4 4900.6 4701.8 4754.7 4762.3 4767.2 4797.7 4846.2 4865.6 4890.9 4902.5 4919.1 5429.7 5461.9 5480.5 5498.5 5554.5 5579.4 5597.7 5603.4 5606.9 5645.8 5225.7 5234.6 5236.1 5256.2 5288.4 5614.7 5677.1 5687.2 5701.9 5736.5 5409.4 5452.7 5452.9 5461.6 5492.0 5477.7 5521.2 5528.3 5534.2 5570.0 5422.5 5497.5 5534.5 5545.4 5595.6 5485.2 5532.7 5550.0 5577.8 5624.6 4265.7 4271.1 4308.3 4322.1 4323.5 3875.4 3889.6 3890.6 3899.0 3926.6 5251.1 5275.8 5282.6 5291.8 5295.0 5498.5 5591.2 5592.7 5594.6 5642.2 5228.8 5241.3 5241.3 5271.9 5291.0 4824.6 4831.4 4844.8 4856.7 4896.9 5899.6 5905.6 5906.5 5934.9 5935.1 5485.6 5516.5 5549.9 5558.6 5592.7 5835.0 5840.3 5858.1 5858.3 5863.1 5474.1 5517.0 5521.4 5534.7 5548.7 5578.0 5696.9 5703.6 5705.9 5745.3 5484.2 5492.0 5495.2 5503.9 5505.3 5392.9 5482.2 5482.4 5485.9 5494.2 5267.7 5329.8 5386.4 5392.3 5423.5 5395.2 5531.6 5542.4 5561.9 5571.3 5305.7 5333.3 5402.4 5407.1 5466.0 13:15:56 INFO - PROCESS | 3487 | 13:15:56 INFO - PROCESS | 3487 | [#1] ext.html Cycles:180 Average:40891.94 Median:36043.05 stddev:61884.16 (171.7%) stddev-sans-first:61983.55 13:15:56 INFO - PROCESS | 3487 | Values: 528.2 541.4 575.0 583.1 583.7 28362.3 37437.0 37537.2 37720.0 37851.0 39582.2 40270.8 40287.8 40319.0 40401.2 8479.9 8632.5 8761.3 8762.6 8800.6 8510.4 8716.9 8757.5 8758.0 8976.8 8878.6 8886.5 8942.3 8963.1 8974.6 8766.1 8805.0 8862.0 8874.3 8934.4 8629.6 8752.2 8777.9 8801.5 8835.3 39989.4 40434.6 40521.8 40746.2 40777.0 3421.5 3566.9 3666.0 4101.8 4117.9 26380.1 27025.5 27204.7 27215.3 27234.0 3694.2 3769.8 3793.2 3799.0 3994.8 212837.0 215062.0 215393.0 215849.0 215901.0 55851.0 56002.0 56219.0 56259.4 56456.2 63899.4 63966.0 64032.0 64094.0 64287.0 15246.7 15338.1 15404.4 15423.7 15451.9 10730.7 10794.0 10811.6 10820.1 10859.2 20621.8 20715.5 20724.2 20728.2 21036.0 8059.3 8298.3 8315.2 8322.3 8364.0 943.3 968.7 1001.4 1037.5 1079.9 28952.9 28980.2 28996.0 29303.0 29333.4 1029.4 1063.4 1070.2 1082.7 1090.0 14632.3 14976.6 15045.3 15245.9 15317.3 289088.0 290945.0 293146.0 293195.0 294984.0 50325.5 52050.7 52132.7 52140.7 52162.0 1320.1 1342.6 1360.1 1369.2 1371.3 26885.3 27889.4 28386.9 28408.0 28539.9 37203.0 37273.6 37312.4 37377.6 37596.4 191743.0 194126.0 194763.0 195030.0 196854.0 27585.6 27951.4 28232.4 28440.3 28670.4 41816.8 42168.2 42489.4 42592.6 43010.1 35816.5 35864.0 35959.8 36010.6 36386.0 35702.0 36075.5 36137.8 36462.0 36869.0 34507.3 34820.0 35499.5 35522.5 35686.6 30809.7 31700.8 31800.2 31839.5 32218.4 24028.4 24915.0 25100.0 25143.0 25200.9 13:15:56 INFO - PROCESS | 3487 | 13:15:56 INFO - PROCESS | 3487 | [#2] jquery.html Cycles:180 Average:23270.10 Median:389670.50 stddev:64513.64 (16.6%) stddev-sans-first:64671.66 13:15:56 INFO - PROCESS | 3487 | Values: 346.1 346.9 352.5 353.0 355.4 16377.7 17048.8 17142.7 17539.5 17990.4 10024.1 10184.7 10233.6 11544.0 15572.1 4718.9 4953.1 4971.4 4977.1 4993.1 4906.1 4983.8 5180.1 5202.0 5205.3 4894.2 5132.3 5152.4 5177.5 5183.2 4987.1 4997.9 4999.5 5015.2 5015.9 4822.7 4836.4 4999.4 5196.6 5221.4 19269.0 19283.4 19327.3 19609.4 19678.1 2099.1 2248.9 2387.7 2446.4 2571.0 8602.1 8844.0 10169.8 11253.1 13021.9 1823.6 1827.2 1838.2 1911.5 1943.8 58528.4 58622.4 59520.4 60253.1 60633.1 9900.3 9916.0 9989.9 9993.3 10100.9 12062.3 12892.5 12930.3 12942.4 13014.7 7148.9 7302.2 7363.6 7406.8 7426.4 7282.9 7311.9 7354.0 7379.0 7447.3 4058.8 4114.5 4136.2 4298.2 4324.0 1836.6 1877.7 1883.5 1912.8 1918.4 956.2 971.7 981.1 1008.9 1010.4 16186.2 16265.7 16274.3 16559.6 16608.3 956.7 963.9 986.1 991.6 1048.4 9252.4 9280.0 9361.3 9556.3 9678.4 389475.0 389866.0 391434.0 394004.0 399948.0 69931.0 72851.6 72946.0 75360.2 75366.6 999.8 1004.3 1012.7 1013.2 1020.4 14335.6 14582.6 14683.0 14745.4 14966.8 22068.1 22351.0 22474.6 31016.0 33685.5 40069.0 41626.6 41632.0 41645.8 42031.8 7354.5 7555.4 7580.7 7764.5 7847.8 11702.9 12247.8 12358.9 12506.1 12784.6 10376.4 10452.5 10552.9 10636.1 10933.0 10435.9 10483.0 10502.8 10533.0 10633.1 10135.9 10281.9 10339.5 10399.2 10603.9 7378.3 7570.1 7619.4 7624.2 8170.5 9186.3 10026.9 10086.2 10229.5 10306.3 13:15:56 INFO - PROCESS | 3487 | 13:15:56 INFO - PROCESS | 3487 | [#3] mootools.html Cycles:180 Average:5142.15 Median:6373.54 stddev:2583.19 (40.5%) stddev-sans-first:2575.70 13:15:56 INFO - PROCESS | 3487 | Values: 1471.6 1475.1 1665.4 1765.1 1820.1 6180.4 6627.0 7195.5 7396.6 7410.7 7087.8 7136.5 7144.9 7194.9 7215.1 2190.4 2219.3 2225.1 2228.5 2231.6 2170.8 2194.5 2200.4 2222.0 2239.5 2147.7 2171.4 2186.4 2197.3 2241.7 2184.2 2210.1 2210.5 2213.5 2216.0 2217.6 2249.7 2256.3 2258.9 2262.7 7020.2 7047.8 7053.2 7068.9 7101.9 4456.0 4466.3 4537.7 4548.3 4549.8 2879.3 3039.2 3044.4 3061.1 3061.8 898.6 902.8 922.3 926.7 943.5 9848.0 9851.9 9874.1 9887.6 9927.9 4048.6 4096.7 4097.5 4114.8 4204.5 8447.7 8544.0 8564.1 8566.2 8569.0 4514.7 4517.3 4539.3 4540.3 4546.4 3936.8 4103.0 4105.7 4114.3 4143.1 3396.8 3399.5 3449.3 3453.7 3482.8 1033.1 1040.2 1041.7 1061.3 1065.8 1335.1 1338.7 1344.4 1345.1 1367.5 6902.1 7066.5 7070.9 7158.0 7169.3 1116.8 1132.1 1137.6 1142.5 1151.6 5446.0 5497.4 5509.4 5510.9 5511.1 8371.8 8452.2 8830.4 8847.7 8954.9 8963.9 8976.4 9000.5 9022.6 9056.3 6829.7 6861.2 6929.0 6939.0 6996.4 6604.3 6683.2 6691.9 6711.8 6761.6 7537.4 7692.3 7693.8 7832.4 7898.1 7426.3 7528.5 7537.4 7570.7 7870.9 6067.7 6537.5 6554.4 6650.5 6905.0 6912.4 6936.5 6950.5 6953.7 6978.6 6333.5 6364.4 6382.7 6452.8 6530.4 6285.6 6285.8 6383.4 6409.5 6440.2 6587.8 6596.2 6625.1 6638.7 6646.2 6073.7 6096.2 6172.9 6176.8 6180.5 6427.9 6432.0 6467.2 6500.2 6534.5 13:15:56 INFO - PROCESS | 3487 | 13:15:56 INFO - PROCESS | 3487 | [#4] prototype.html Cycles:180 Average:5534.31 Median:6372.23 stddev:1767.84 (27.7%) stddev-sans-first:1728.71 13:15:56 INFO - PROCESS | 3487 | Values: 307.0 309.2 317.9 319.4 321.3 6152.8 6290.0 6344.6 6395.6 6476.5 6176.9 6199.1 6234.3 6237.8 6250.7 4519.6 4617.1 4631.4 4639.7 4724.4 4611.6 4619.6 4627.7 4629.7 4641.4 4533.8 4582.8 4598.4 4629.4 4639.0 4645.1 4645.6 4649.2 4653.2 4655.1 3967.2 3971.2 3972.0 3975.7 3988.5 5942.2 5950.6 5950.7 5952.3 5996.9 5240.1 5341.3 5359.5 5376.6 5383.3 6584.0 6605.4 6612.7 6613.7 6616.0 4339.5 4344.5 4357.3 4361.7 4379.2 6869.7 6880.4 6958.1 6964.0 6968.7 4321.3 4323.4 4323.9 4325.4 4331.2 4313.9 4353.9 4442.0 4447.3 4460.5 5303.2 5316.2 5353.0 5354.3 5362.7 6670.1 6715.7 6721.2 6725.6 6731.6 1571.8 1575.0 1575.9 1576.5 1579.2 991.0 1011.7 1024.5 1025.0 1038.5 6367.6 6376.8 6381.1 6398.2 6403.0 6897.3 6914.4 6921.0 6921.3 6946.1 6267.2 6338.2 6363.2 6393.2 6430.4 3753.7 3755.8 3756.4 3758.8 3773.6 7329.4 7331.5 7336.5 7344.7 7349.0 7105.9 7111.9 7127.5 7155.1 7170.0 7079.3 7333.7 7340.2 7369.7 7395.6 6929.5 6957.9 6966.4 6966.7 6969.1 6820.8 6856.9 6870.8 6883.3 6889.2 7288.6 7342.4 7345.7 7375.1 7380.1 4351.1 4403.4 4428.9 4459.8 4468.5 6929.1 6997.4 7023.9 7024.5 7038.8 6711.5 6734.1 6738.0 6738.1 6740.3 6691.4 6725.8 6774.1 6781.6 6784.5 6442.6 6598.7 6615.5 6621.1 6658.9 6778.7 6788.2 6810.3 6818.2 6835.6 6655.0 6656.5 6658.7 6659.8 6676.6 13:15:56 INFO - PROCESS | 3487 | 13:15:56 INFO - PROCESS | 3487 | [#5] yui.html Cycles:180 Average:13674.28 Median:46674.00 stddev:15902.29 (34.1%) stddev-sans-first:15917.57 13:15:56 INFO - PROCESS | 3487 | Values: 813.0 816.3 822.6 827.0 855.7 13960.9 13983.4 14045.7 14117.0 14150.0 11748.2 12575.9 12990.3 13029.9 13104.6 814.8 829.9 830.8 834.6 836.6 828.4 833.6 834.6 835.3 837.2 862.5 867.5 871.0 871.8 872.2 866.2 866.5 867.6 867.9 868.3 632.7 638.6 638.8 639.0 642.2 13347.7 13378.4 13397.0 13411.2 13433.4 13390.1 13483.5 13645.2 13698.9 13703.4 10024.4 10514.2 10563.8 10674.0 11176.9 3641.1 3643.2 3665.9 3674.7 3776.9 49269.5 50107.0 50712.2 50815.5 50868.2 10311.5 10398.2 10430.3 10546.4 10550.7 18034.3 18041.4 18083.8 18116.3 18121.8 7523.2 7618.9 7621.8 7694.9 7828.2 4210.4 4297.4 4315.3 4355.9 4440.5 3098.7 3135.2 3146.0 3154.8 3169.0 576.0 584.9 592.8 593.1 604.7 681.5 687.3 697.6 710.2 712.4 8197.5 8880.8 8913.5 9030.8 9075.5 568.9 569.9 595.9 669.7 714.3 4055.8 4121.1 4212.9 4255.2 4268.0 56232.7 57138.7 57310.4 57537.7 57787.7 49309.0 49939.0 50887.7 51095.7 51189.7 46207.5 46317.0 47031.0 47153.3 47318.3 8363.7 8453.5 8457.2 8503.6 8720.3 34339.3 34879.0 35018.0 35748.5 35982.8 39126.0 39350.2 41050.6 43879.6 44174.6 10049.9 10396.0 10433.5 10606.6 10655.7 11292.5 11313.3 11383.6 11547.5 12019.8 10717.8 10978.9 11003.2 11163.3 11246.2 10453.6 10724.5 10762.6 10773.0 10795.5 9992.3 10008.5 10029.4 10034.0 10051.9 8088.6 8360.4 8374.4 8378.3 8505.5 8586.4 8613.4 8761.8 8780.3 9125.5 13:15:56 INFO - PROCESS | 3487 | -------- Summary: end -------- 13:15:56 INFO - PROCESS | 3487 | 13:15:57 INFO - PROCESS | 3487 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:15:57 INFO - PROCESS | 3487 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:15:57 INFO - PROCESS | 3487 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:15:57 INFO - PROCESS | 3487 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:15:57 INFO - PROCESS | 3487 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:15:57 INFO - PROCESS | 3487 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:15:57 INFO - PROCESS | 3487 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:15:57 INFO - PROCESS | 3487 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:15:57 INFO - PROCESS | 3487 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:15:57 INFO - TEST-INFO | 3487: exit 0 13:15:57 INFO - TEST-OK | dromaeo_css | took 1112196ms 13:15:57 INFO - TEST-START | kraken 13:15:57 INFO - operating with platform_type : linux_ 13:15:57 INFO - Initialising browser for kraken test... 13:15:57 INFO - TEST-INFO | started process 3724 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbIPR8D/profile http://localhost:56046/getInfo.html) 13:16:01 INFO - PROCESS | 3724 | 13:16:01 INFO - PROCESS | 3724 | (process:3797): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:16:01 INFO - PROCESS | 3724 | __metrics Screen width/height:1600/1200 13:16:01 INFO - PROCESS | 3724 | colorDepth:24 13:16:01 INFO - PROCESS | 3724 | Browser inner width/height: 1024/697 13:16:01 INFO - PROCESS | 3724 | __metrics 13:16:02 ERROR - PROCESS | 3724 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 13:16:02 INFO - PROCESS | 3724 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:16:02 INFO - PROCESS | 3724 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:16:02 INFO - PROCESS | 3724 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:16:02 INFO - PROCESS | 3724 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:16:02 INFO - PROCESS | 3724 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:16:02 INFO - PROCESS | 3724 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:16:02 INFO - PROCESS | 3724 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:16:02 INFO - PROCESS | 3724 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:16:02 INFO - PROCESS | 3724 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:16:03 INFO - TEST-INFO | 3724: exit 0 13:16:03 INFO - Browser initialized. 13:16:03 INFO - Running cycle 1/1 for kraken test... 13:16:03 INFO - TEST-INFO | started process 3848 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpbIPR8D/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:16:04 INFO - PROCESS | 3848 | 13:16:04 INFO - PROCESS | 3848 | (process:3908): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:16:15 INFO - PROCESS | 3848 | RSS: Main: 161423360 13:16:15 INFO - PROCESS | 3848 | 13:16:17 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:56046/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56046/tests/kraken/driver.html?testName=audio-beat-detection) 13:16:18 INFO - PROCESS | 3848 | RSS: Main: 167645184 13:16:18 INFO - PROCESS | 3848 | 13:16:21 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:56046/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56046/tests/kraken/driver.html?testName=audio-dft) 13:16:21 INFO - PROCESS | 3848 | RSS: Main: 171593728 13:16:21 INFO - PROCESS | 3848 | 13:16:24 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:56046/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56046/tests/kraken/driver.html?testName=audio-fft) 13:16:25 INFO - PROCESS | 3848 | RSS: Main: 164483072 13:16:25 INFO - PROCESS | 3848 | 13:16:27 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:56046/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56046/tests/kraken/driver.html?testName=audio-oscillator) 13:16:27 INFO - PROCESS | 3848 | RSS: Main: 164319232 13:16:27 INFO - PROCESS | 3848 | 13:16:30 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:56046/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56046/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:16:30 INFO - PROCESS | 3848 | RSS: Main: 165625856 13:16:30 INFO - PROCESS | 3848 | 13:16:33 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:56046/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56046/tests/kraken/driver.html?testName=imaging-darkroom) 13:16:34 INFO - PROCESS | 3848 | RSS: Main: 164745216 13:16:34 INFO - PROCESS | 3848 | 13:16:37 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:56046/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56046/tests/kraken/driver.html?testName=imaging-desaturate) 13:16:38 INFO - PROCESS | 3848 | RSS: Main: 164921344 13:16:38 INFO - PROCESS | 3848 | 13:16:41 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:56046/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56046/tests/kraken/driver.html?testName=json-parse-financial) 13:16:41 INFO - PROCESS | 3848 | RSS: Main: 165789696 13:16:41 INFO - PROCESS | 3848 | 13:16:43 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:56046/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56046/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:16:43 INFO - PROCESS | 3848 | RSS: Main: 166133760 13:16:43 INFO - PROCESS | 3848 | 13:16:45 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:56046/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56046/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:16:46 INFO - PROCESS | 3848 | RSS: Main: 166801408 13:16:46 INFO - PROCESS | 3848 | 13:16:48 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:56046/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56046/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:16:48 INFO - PROCESS | 3848 | RSS: Main: 165572608 13:16:48 INFO - PROCESS | 3848 | 13:16:51 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:56046/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56046/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:16:52 INFO - PROCESS | 3848 | RSS: Main: 167079936 13:16:52 INFO - PROCESS | 3848 | 13:16:54 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:56046/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56046/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:16:55 INFO - PROCESS | 3848 | RSS: Main: 166170624 13:16:55 INFO - PROCESS | 3848 | 13:16:56 INFO - PROCESS | 3848 | Cycle 1(1): loaded http://localhost:56046/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56046/tests/kraken/driver.html?testName=ai-astar) 13:16:57 INFO - PROCESS | 3848 | RSS: Main: 168480768 13:16:57 INFO - PROCESS | 3848 | 13:16:57 INFO - PROCESS | 3848 | __start_tp_report 13:16:57 INFO - PROCESS | 3848 | _x_x_mozilla_page_load 13:16:57 INFO - PROCESS | 3848 | _x_x_mozilla_page_load_details 13:16:57 INFO - PROCESS | 3848 | |i|pagename|runs| 13:16:57 INFO - PROCESS | 3848 | |0;ai-astar;115;108;115;112;113;124;112;111;111;112 13:16:57 INFO - PROCESS | 3848 | |1;audio-beat-detection;157;130;151;174;128;158;150;136;172;127 13:16:57 INFO - PROCESS | 3848 | |2;audio-dft;164;162;162;163;162;162;163;171;167;162 13:16:57 INFO - PROCESS | 3848 | |3;audio-fft;74;72;72;75;73;130;75;72;82;74 13:16:57 INFO - PROCESS | 3848 | |4;audio-oscillator;95;95;147;95;96;97;142;95;96;148 13:16:57 INFO - PROCESS | 3848 | |5;imaging-gaussian-blur;122;116;115;116;115;115;115;115;115;115 13:16:57 INFO - PROCESS | 3848 | |6;imaging-darkroom;147;147;146;147;146;146;146;146;146;146 13:16:57 INFO - PROCESS | 3848 | |7;imaging-desaturate;97;97;96;97;97;97;96;97;96;96 13:16:57 INFO - PROCESS | 3848 | |8;json-parse-financial;56;55;56;55;58;57;57;63;55;54 13:16:57 INFO - PROCESS | 3848 | |9;json-stringify-tinderbox;67;68;67;68;68;70;68;67;68;67 13:16:57 INFO - PROCESS | 3848 | |10;stanford-crypto-aes;84;85;96;85;84;92;84;83;85;84 13:16:57 INFO - PROCESS | 3848 | |11;stanford-crypto-ccm;119;127;123;128;120;117;119;117;121;119 13:16:57 INFO - PROCESS | 3848 | |12;stanford-crypto-pbkdf2;145;151;155;152;158;143;144;152;151;148 13:16:57 INFO - PROCESS | 3848 | |13;stanford-crypto-sha256-iterative;68;68;70;70;74;70;69;69;67;72 13:16:57 INFO - PROCESS | 3848 | __end_tp_report 13:16:57 INFO - PROCESS | 3848 | __start_cc_report 13:16:57 INFO - PROCESS | 3848 | _x_x_mozilla_cycle_collect,796 13:16:57 INFO - PROCESS | 3848 | __end_cc_report 13:16:57 INFO - PROCESS | 3848 | __startTimestamp1456694217146__endTimestamp 13:16:57 INFO - PROCESS | 3848 | 13:16:57 INFO - PROCESS | 3848 | ------- Summary: start ------- 13:16:57 INFO - PROCESS | 3848 | Number of tests: 14 13:16:57 INFO - PROCESS | 3848 | 13:16:57 INFO - PROCESS | 3848 | [#0] ai-astar Cycles:10 Average:113.30 Median:112.50 stddev:4.27 (3.8%) stddev-sans-first:4.48 13:16:57 INFO - PROCESS | 3848 | Values: 115.0 108.0 115.0 112.0 113.0 124.0 112.0 111.0 111.0 112.0 13:16:57 INFO - PROCESS | 3848 | 13:16:57 INFO - PROCESS | 3848 | [#1] audio-beat-detection Cycles:10 Average:148.30 Median:154.00 stddev:17.49 (11.4%) stddev-sans-first:18.27 13:16:57 INFO - PROCESS | 3848 | Values: 157.0 130.0 151.0 174.0 128.0 158.0 150.0 136.0 172.0 127.0 13:16:57 INFO - PROCESS | 3848 | 13:16:57 INFO - PROCESS | 3848 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:2.97 (1.8%) stddev-sans-first:3.15 13:16:57 INFO - PROCESS | 3848 | Values: 164.0 162.0 162.0 163.0 162.0 162.0 163.0 171.0 167.0 162.0 13:16:57 INFO - PROCESS | 3848 | 13:16:57 INFO - PROCESS | 3848 | [#3] audio-fft Cycles:10 Average:79.90 Median:74.00 stddev:17.85 (24.1%) stddev-sans-first:18.80 13:16:57 INFO - PROCESS | 3848 | Values: 74.0 72.0 72.0 75.0 73.0 130.0 75.0 72.0 82.0 74.0 13:16:57 INFO - PROCESS | 3848 | 13:16:57 INFO - PROCESS | 3848 | [#4] audio-oscillator Cycles:10 Average:110.60 Median:95.00 stddev:24.25 (25.5%) stddev-sans-first:25.06 13:16:57 INFO - PROCESS | 3848 | Values: 95.0 95.0 147.0 95.0 96.0 97.0 142.0 95.0 96.0 148.0 13:16:57 INFO - PROCESS | 3848 | 13:16:57 INFO - PROCESS | 3848 | [#5] imaging-gaussian-blur Cycles:10 Average:115.90 Median:115.00 stddev:2.18 (1.9%) stddev-sans-first:0.44 13:16:57 INFO - PROCESS | 3848 | Values: 122.0 116.0 115.0 116.0 115.0 115.0 115.0 115.0 115.0 115.0 13:16:57 INFO - PROCESS | 3848 | 13:16:57 INFO - PROCESS | 3848 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 13:16:57 INFO - PROCESS | 3848 | Values: 147.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 13:16:57 INFO - PROCESS | 3848 | 13:16:57 INFO - PROCESS | 3848 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 13:16:57 INFO - PROCESS | 3848 | Values: 97.0 97.0 96.0 97.0 97.0 97.0 96.0 97.0 96.0 96.0 13:16:57 INFO - PROCESS | 3848 | 13:16:57 INFO - PROCESS | 3848 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.50 stddev:2.55 (4.5%) stddev-sans-first:2.69 13:16:57 INFO - PROCESS | 3848 | Values: 56.0 55.0 56.0 55.0 58.0 57.0 57.0 63.0 55.0 54.0 13:16:57 INFO - PROCESS | 3848 | 13:16:57 INFO - PROCESS | 3848 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 13:16:57 INFO - PROCESS | 3848 | Values: 67.0 68.0 67.0 68.0 68.0 70.0 68.0 67.0 68.0 67.0 13:16:57 INFO - PROCESS | 3848 | 13:16:57 INFO - PROCESS | 3848 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:85.00 stddev:4.26 (5.0%) stddev-sans-first:4.45 13:16:57 INFO - PROCESS | 3848 | Values: 84.0 85.0 96.0 85.0 84.0 92.0 84.0 83.0 85.0 84.0 13:16:57 INFO - PROCESS | 3848 | 13:16:57 INFO - PROCESS | 3848 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:120.50 stddev:3.86 (3.2%) stddev-sans-first:4.02 13:16:57 INFO - PROCESS | 3848 | Values: 119.0 127.0 123.0 128.0 120.0 117.0 119.0 117.0 121.0 119.0 13:16:57 INFO - PROCESS | 3848 | 13:16:57 INFO - PROCESS | 3848 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.90 Median:151.50 stddev:4.86 (3.2%) stddev-sans-first:4.82 13:16:57 INFO - PROCESS | 3848 | Values: 145.0 151.0 155.0 152.0 158.0 143.0 144.0 152.0 151.0 148.0 13:16:57 INFO - PROCESS | 3848 | 13:16:57 INFO - PROCESS | 3848 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:2.06 (2.9%) stddev-sans-first:2.09 13:16:57 INFO - PROCESS | 3848 | Values: 68.0 68.0 70.0 70.0 74.0 70.0 69.0 69.0 67.0 72.0 13:16:57 INFO - PROCESS | 3848 | -------- Summary: end -------- 13:16:57 INFO - PROCESS | 3848 | 13:16:57 INFO - PROCESS | 3848 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:16:57 INFO - PROCESS | 3848 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:16:57 INFO - PROCESS | 3848 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:16:57 INFO - PROCESS | 3848 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:16:57 INFO - PROCESS | 3848 | nsHttpConnectionMgr::Shutdown() ProcessNextEvent 13:16:59 INFO - TEST-INFO | 3848: exit 0 13:16:59 INFO - TEST-OK | kraken | took 61687ms 13:16:59 INFO - SUITE-END | took 1173s 13:16:59 INFO - Completed test suite (00:19:34) 13:16:59 INFO - Working with test: dromaeo_css 13:16:59 INFO - Generating results file: dromaeo_css 13:16:59 INFO - Working with test: kraken 13:16:59 INFO - Generating results file: kraken 13:16:59 INFO - javascript benchmark 13:16:59 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:16:59 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 13:16:59 INFO - process_Request line: dromaeo_css 6789.72 graph.html#tests=[[72,63,43]] 13:16:59 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:16:59 INFO - process_Request line: kraken 1525.90 graph.html#tests=[[232,63,43]] 13:16:59 INFO - RETURN: dromaeo_css: 6789.72 13:16:59 INFO - RETURN: kraken: 1525.90 13:16:59 INFO - javascript benchmark 13:16:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3117.3765246950607, 3199.8400079995995, 3222.5166225066223, 3243.0270918724386, 3250.0737289872377, 4968.0809050325715, 5192.402873669529, 5221.68669879807, 5226.634135610509, 5285.973570132144, 5111.233315002752, 5151.227315902607, 5183.092958732225, 5214.06146893559, 5257.211418287249, 44.672980915749335, 4658.90682186356, 4784.880377990543, 4862.708237505743, 4880.8047678092835, 4708.811647534095, 4755.90488190236, 4767.284907263921, 4771.928421073687, 4838.274258861182, 4750.714957102585, 4770.785314660866, 4782.354382158399, 4788.138135135691, 4804.111239420683, 4642.326862604938, 4737.194676904935, 4858.514148585148, 4862.416510018785, 4900.58345040672, 4701.78841952113, 4754.7147171169845, 4762.28565715142, 4767.189577771787, 4797.688150270221, 4846.248831431134, 4865.6107511399005, 4890.877728056791, 4902.4852390498845, 4919.065377578248, 5429.701366424845, 5461.9453805462235, 5480.451954804527, 5498.532624726903, 5554.472325129106, 5579.442055794429, 5597.6641401515635, 5603.3836278009385, 5606.943930560683, 5645.830625081254, 5225.660332078441, 5234.555062819665, 5236.136037553799, 5256.211568264791, 5288.365396152486, 5614.719264036782, 5677.148427735872, 5687.232223649754, 5701.857453563694, 5736.541076713853, 5409.350877894599, 5452.672839629635, 5452.890942181134, 5461.617686761889, 5492.038893193675, 5477.698726569997, 5521.2270282160525, 5528.336599607992, 5534.1975413565615, 5569.972150139223, 5422.484863937999, 5497.47773961473, 5534.501894829405, 5545.445455454503, 5595.63628364155, 5485.177223416519, 5532.723363831792, 5549.972250138723, 5577.776888924479, 5624.55003599711, 4265.722728022731, 4271.10306835568, 4308.289132293199, 4322.113966636832, 4323.546027667113, 3875.379939209713, 3889.591592882763, 3890.5525864525944, 3898.9805050975133, 3926.6269704378037, 5251.054810134213, 5275.762590683428, 5282.550983166474, 5291.841244762663, 5294.97352513235, 5498.505134537911, 5591.217229587861, 5592.692401917852, 5594.552435805126, 5642.210090587321, 5228.764705588258, 5241.344831896013, 5241.344831896013, 5271.868203294948, 5291.0, 4824.638152138604, 4831.4202295724735, 4844.781984810692, 4856.708597484162, 4896.853094407174, 5899.557533185029, 5905.645661260338, 5906.497947674496, 5934.8813023739285, 5935.139404786368, 5485.6434331768305, 5516.503514683698, 5549.861253468614, 5558.555315574825, 5592.69240191777, 5835.037218858841, 5840.269966254218, 5858.091995740497, 5858.2677165354335, 5863.061910094364, 5474.124140137559, 5516.972415138059, 5521.3926468087675, 5534.723263836872, 5548.69482178484, 5578.0, 5696.914546281892, 5703.600747947604, 5705.857353566194, 5745.3105627324985, 5484.232207490874, 5492.038893193755, 5495.175723641326, 5503.944960550343, 5505.3393592767525, 5392.892142157057, 5482.17767334903, 5482.39693633708, 5485.862853428696, 5494.1758736189895, 5267.710275934707, 5329.760160792696, 5386.35363756336, 5392.299001129828, 5423.484768946943, 5395.190721391823, 5531.612787104864, 5542.445755424586, 5561.888762224814, 5571.331440227199, 5305.708186049805, 5333.333333333333, 5402.405735369028, 5407.07832077076, 5466.043442397644], "unit": "score", "name": "dojo.html", "value": 5122.380076371655}, {"lowerIsBetter": false, "replicates": [528.2287859724802, 541.3530830657363, 574.9827505174843, 583.1486030395622, 583.7285662167092, 28362.290942726417, 37437.0, 37537.249255014955, 37720.0, 37851.0, 39582.20835583287, 40270.7986460068, 40287.79856100723, 40319.0, 40401.19197616046, 8479.915200847974, 8632.525211113387, 8761.299096072331, 8762.561871906379, 8800.603972821207, 8510.361722870779, 8716.869246961302, 8757.474551526897, 8757.956210218972, 8976.775580610472, 8878.644854205824, 8886.511241881693, 8942.284617230605, 8963.058878817728, 8974.551272436385, 8766.079561646064, 8805.031446540908, 8862.0, 8874.29005679544, 8934.374593778439, 8629.56852157396, 8752.168543988311, 8777.868331975025, 8801.515916624583, 8835.293176545862, 39989.40015899764, 40434.595654043376, 40521.79739101315, 40746.18507629831, 40777.0, 3421.5038819371302, 3566.857325706969, 3665.981670091659, 4101.794910254505, 4117.876463706094, 26380.0766973155, 27025.45949081027, 27204.72795272042, 27215.319617009733, 27234.0, 3694.1503454205413, 3769.8492060317553, 3793.165503589206, 3798.962010379916, 3994.840206391741, 212837.0, 215062.0, 215393.0, 215849.0, 215900.99999999843, 55851.0, 56002.0, 56219.0, 56259.43740562624, 56456.15315770267, 63899.361006390274, 63966.0, 64032.0, 64094.0, 64287.0, 15246.695066098617, 15338.079715217124, 15404.383824647113, 15423.691526169638, 15451.922740386452, 10730.731731706614, 10794.028537431668, 10811.6215932442, 10820.134389248999, 10859.2398532102, 20621.793782062286, 20715.4821129473, 20724.171033158807, 20728.170873165207, 21036.0, 8059.274665280153, 8298.336133109337, 8315.210055044761, 8322.334213262924, 8364.0, 943.3160958305174, 968.6803354892868, 1001.3691374434205, 1037.4968140451874, 1079.9298045627008, 28952.855235723688, 28980.20461527773, 28996.0, 29303.0, 29333.413331733245, 1029.351508549609, 1063.4204358624413, 1070.2294348069377, 1082.6535508637319, 1089.9509522071526, 14632.341544630517, 14976.62558436026, 15045.322960466587, 15245.923770381078, 15317.31072101758, 289088.0, 290945.0, 293146.0, 293195.0, 294984.0, 50325.49674503281, 52050.73974630103, 52132.739336303835, 52140.739296303276, 52162.0, 1320.0627554436458, 1342.61735405409, 1360.1023324605712, 1369.2127026959338, 1371.3417559571262, 26885.327866803487, 27889.44221115607, 28386.85806570954, 28408.0, 28539.857300713364, 37203.0, 37273.627263727016, 37312.44031339586, 37377.62622373742, 37596.436053458674, 191743.0, 194126.0, 194763.0, 195030.0, 196854.0, 27585.586216207175, 27951.44097118087, 28232.43535129327, 28440.28899277452, 28670.42659146847, 41816.790916045225, 42168.1566368677, 42489.36265955951, 42592.5740742601, 43010.13979720326, 35816.4627530582, 35864.0, 35959.82020089883, 36010.63989360178, 36386.0, 35702.0, 36075.458868116475, 36137.81931090328, 36462.0, 36869.0, 34507.30985380329, 34820.0, 35499.46750798688, 35522.467162993096, 35686.64313356833, 30809.69190308158, 31700.84127205122, 31800.204994875312, 31839.522407164375, 32218.35563288768, 24028.39929001719, 24915.0, 25100.00698303141, 25143.0, 25200.873995629903], "unit": "score", "name": "ext.html", "value": 17895.66669929819}, {"lowerIsBetter": false, "replicates": [346.08633208329996, 346.9460792110705, 352.5135313267691, 353.01156761069035, 355.37276706612835, 16377.672446551062, 17048.82951170488, 17142.657146857055, 17539.473815785514, 17990.370337038174, 10024.097831195191, 10184.694459166218, 10233.641822536212, 11544.018758405524, 15572.143532105729, 4718.90562188756, 4953.108440480712, 4971.353724015873, 4977.104121258172, 4993.101241776479, 4906.141425250585, 4983.825566105187, 5180.067587834188, 5201.973990130044, 5205.271262023301, 4894.1679914414635, 5132.332796736419, 5152.355955505562, 5177.456367081459, 5183.248428977796, 4987.0524600325825, 4997.875053123665, 4999.450060493343, 5015.172496538067, 5015.924761128567, 4822.734749588772, 4836.371271734687, 4999.400071991348, 5196.58427325813, 5221.373435187764, 19269.036548172677, 19283.42149735496, 19327.323543675902, 19609.411717648494, 19678.114484848214, 2099.139352865333, 2248.910043598254, 2387.713474383068, 2446.351716795051, 2571.010161087976, 8602.139786021347, 8844.0, 10169.796604067877, 11253.099752019818, 13021.934890325489, 1823.5988082621934, 1827.2142978519232, 1838.2187570282576, 1911.4743445552444, 1943.7570303712037, 58528.41471585315, 58622.41377586212, 59520.404795951916, 60253.09620355698, 60633.090503642925, 9900.306978511579, 9916.0, 9989.900100999042, 9993.250506212064, 10100.898991009995, 12062.336571488653, 12892.48430062787, 12930.288834114213, 12942.417591208417, 13014.739705205842, 7148.92851071493, 7302.160251571031, 7363.631818409058, 7406.777796666109, 7426.368758655575, 7282.890756638654, 7311.8537629248185, 7353.963230183922, 7379.040724705754, 7447.329740323397, 4058.7564746115327, 4114.506259248909, 4136.234796562646, 4298.20483210607, 4324.0, 1836.6143109946793, 1877.6807942649782, 1883.5385330594092, 1912.8087191281038, 1918.414883460558, 956.1967946924617, 971.708487453761, 981.0679854138597, 1008.8738907636546, 1010.4190090697878, 16186.19069046543, 16265.674686506203, 16274.26765795542, 16559.586010349838, 16608.25262863174, 956.712986104166, 963.8939716631165, 986.1322036607739, 991.6083147156833, 1048.4495639789172, 9252.398594091363, 9280.02559731232, 9361.251099911991, 9556.283278753983, 9678.370905891095, 389475.0, 389866.0, 391434.0, 394004.0, 399948.0, 69931.0, 72851.63574182095, 72946.0, 75360.24639753532, 75366.62316688382, 999.7850462150673, 1004.3070281505737, 1012.7063151685928, 1013.1995723378449, 1020.4489575629077, 14335.56993290203, 14582.626569016766, 14683.0, 14745.410183592965, 14966.775498367315, 22068.117275308807, 22351.0, 22474.550508990054, 31016.0, 33685.49471757975, 40069.0, 41626.58373416227, 41632.0, 41645.79177104095, 42031.79682031772, 7354.485186036926, 7555.395568354408, 7580.696772129053, 7764.534127952341, 7847.764567062997, 11702.941485292518, 12247.75504489923, 12358.938205308916, 12506.124571279923, 12784.61646150617, 10376.429296388771, 10452.529636166542, 10552.947235263775, 10636.149108071491, 10933.0, 10435.895641043493, 10483.0, 10502.78994420092, 10533.0, 10633.149348052291, 10135.898641013495, 10281.9485902573, 10339.483025848827, 10399.168066554808, 10603.89396106029, 7378.335949764547, 7570.129435114812, 7619.390448763975, 7624.161342252237, 8170.509769413617, 9186.269071428087, 10026.899731002597, 10086.243531735003, 10229.539670714985, 10306.33008854422], "unit": "score", "name": "jquery.html", "value": 8030.689450982703}, {"lowerIsBetter": false, "replicates": [1471.558532440268, 1475.129673492639, 1665.3838079910436, 1765.082157278216, 1820.1172431370792, 6180.3510631383615, 6627.0, 7195.496315257934, 7396.593187374692, 7410.740624078158, 7087.751928682497, 7136.464765142609, 7144.8928266076055, 7194.856102877952, 7215.062041934541, 2190.375742913274, 2219.2676416782424, 2225.10995601759, 2228.5097278598682, 2231.6206244938317, 2170.750363708178, 2194.473326401668, 2200.3508964855328, 2222.0, 2239.484918468753, 2147.7315335583053, 2171.4354267890385, 2186.35502526755, 2197.28588208832, 2241.663750437431, 2184.191849015858, 2210.1490925993526, 2210.53578748463, 2213.4908970936613, 2215.9778402216093, 2217.5897458970144, 2249.6850440938283, 2256.3343813575034, 2258.920937767187, 2262.6832243485924, 7020.227774944752, 7047.753328633525, 7053.188883278437, 7068.939659051132, 7101.89347159793, 4455.955440445587, 4466.33005049242, 4537.659675524316, 4548.272276435788, 4549.795259213311, 2879.294572829649, 3039.1946134274435, 3044.406340763552, 3061.0969763919697, 3061.8315992620396, 898.6495266845935, 902.8374892519344, 922.294444749767, 926.7312479381039, 943.495230051919, 9847.950760246225, 9851.852222216672, 9874.061964113469, 9887.555060022316, 9927.851082233772, 4048.5748996355546, 4096.672266218696, 4097.467329247179, 4114.814833332507, 4204.5375008749015, 8447.704330348532, 8543.957280213559, 8564.100769419247, 8566.18621230982, 8569.0, 4514.70654407469, 4517.34498497716, 4539.296409056601, 4540.318952157203, 4546.40896683429, 3936.8031598419966, 4102.979485102555, 4105.651019663362, 4114.321137012359, 4143.0678097427835, 3396.796192228425, 3399.456087026064, 3449.275652113034, 3453.671901169385, 3482.7562070655317, 1033.0857191385678, 1040.193849766437, 1041.739565108723, 1061.2783307351076, 1065.7708592652461, 1335.085466455481, 1338.6921008168176, 1344.3547097393111, 1345.0920628575673, 1367.5145323410047, 6902.137232845895, 7066.540674856118, 7070.92929070713, 7158.0336654550965, 7169.318914703095, 1116.7543140509074, 1132.0660455124555, 1137.6075254037344, 1142.5030111901349, 1151.6372342712018, 5446.046941785251, 5497.367802702661, 5509.393966663663, 5510.9448905510435, 5511.118221084607, 8371.832563348698, 8452.1547845215, 8830.381873268809, 8847.69033083839, 8954.86567701485, 8963.865542016874, 8976.371653984159, 9000.459972401677, 9022.639094436148, 9056.27549796028, 6829.658517074126, 6861.210960739579, 6929.0, 6939.0, 6996.405305548984, 6604.339566043357, 6683.164604424447, 6691.933080669131, 6711.832204194934, 6761.560498567577, 7537.397008239218, 7692.307692307719, 7693.846123077619, 7832.37341012729, 7898.091719452336, 7426.331630153312, 7528.473006889465, 7537.434692397982, 7570.697172113054, 7870.881936771068, 6067.696615169312, 6537.5096867734155, 6554.442872355903, 6650.534462587572, 6904.965475172592, 6912.447004239548, 6936.4797640176175, 6950.54821436605, 6953.6523173842115, 6978.616176110363, 6333.493320534254, 6364.363563643598, 6382.712777925098, 6452.806415807533, 6530.412262896172, 6285.5600107992, 6285.811425657238, 6383.425491705769, 6409.519286053658, 6440.194975628046, 6587.835304117435, 6596.175478065242, 6625.138731965007, 6638.734450621921, 6646.202455705153, 6073.726682299219, 6096.207493025879, 6172.876542469216, 6176.752929882934, 6180.4746596538, 6427.871442571029, 6432.0, 6467.223933128054, 6500.187476565429, 6534.4772418205475], "unit": "score", "name": "mootools.html", "value": 4281.496666432729}, {"lowerIsBetter": false, "replicates": [306.95856059431986, 309.23310190726994, 317.85378725786154, 319.40909317762146, 321.34766424158965, 6152.846178845525, 6289.9685501572485, 6344.58760180588, 6395.552311338208, 6476.5142614303995, 6176.938230617692, 6199.07013947908, 6234.345393733649, 6237.844053898643, 6250.718717657705, 4519.615832654228, 4617.14582802181, 4631.421072365954, 4639.65202609804, 4724.362211101509, 4611.631069514431, 4619.607333376667, 4627.652926030544, 4629.699069560468, 4641.350210970467, 4533.77331133442, 4582.816687332519, 4598.402207713009, 4629.351890735283, 4638.9536104638855, 4645.094206629708, 4645.605123564501, 4649.1863923813535, 4653.208954477713, 4655.115528049693, 3967.206558688274, 3971.1660551283976, 3971.960280397188, 3975.7216994810374, 3988.541317748467, 5942.168096466498, 5950.613210141327, 5950.702464876739, 5952.255968003999, 5996.880062398771, 5240.082985477527, 5341.278927344798, 5359.544438722674, 5376.569874410038, 5383.327084114486, 6584.0, 6605.438537724299, 6612.702428390734, 6613.702383392759, 6616.040674102228, 4339.479262488521, 4344.500382455994, 4357.324614684729, 4361.6510679145595, 4379.189849877751, 6869.725210991554, 6880.380765731058, 6958.130233720785, 6963.9651801740665, 6968.686409111602, 4321.2653848845775, 4323.351497275434, 4323.913521729548, 4325.372820941009, 4331.220380331508, 4313.870583882489, 4353.869383918487, 4441.955580444154, 4447.3329000650165, 4460.487043989918, 5303.231031500411, 5316.202569614588, 5353.0, 5354.330708661418, 5362.731863406814, 6670.099536562599, 6715.731370745213, 6721.227058888193, 6725.596464212163, 6731.562448440835, 1571.842815718442, 1574.9606259843367, 1575.8739300856134, 1576.5428025872368, 1579.2261791721974, 990.9851352229722, 1011.6509804117568, 1024.5031159887449, 1025.015984654725, 1038.4859494550246, 6367.649779262185, 6376.808695739135, 6381.1066450696935, 6398.232212134573, 6402.967985160044, 6897.3447522485285, 6914.446844252448, 6921.0, 6921.307869213139, 6946.131733533309, 6267.2165979252595, 6338.239411270677, 6363.204599425072, 6393.168888044617, 6430.421262086435, 3753.6621704046765, 3755.8122093895195, 3756.417755247941, 3758.774473531597, 3773.603771603942, 7329.413646908234, 7331.450141239428, 7336.523125996793, 7344.742933997284, 7349.04462419882, 7105.92894071063, 7111.862102063645, 7127.536710113826, 7155.141383033965, 7170.0, 7079.327463890922, 7333.706651733977, 7340.15588207363, 7369.742059027908, 7395.593242371721, 6929.549579277331, 6957.895631565631, 6966.3730264276455, 6966.721331146698, 6969.059177011241, 6820.829479263058, 6856.9314306856295, 6870.828229294308, 6883.346082122191, 6889.242183359726, 7288.562686238843, 7342.412606991321, 7345.714499962592, 7375.078115235596, 7380.114386273682, 4351.129774045267, 4403.427554418034, 4428.889277768081, 4459.821607135808, 4468.4637843458995, 6929.133858267716, 6997.370236678723, 7023.859522809413, 7024.5434046786795, 7038.824029399306, 6711.530192886451, 6734.124563806674, 6738.0, 6738.124043874265, 6740.292269311848, 6691.397774200345, 6725.831854203684, 6774.119364482585, 6781.559198652072, 6784.525083244323, 6442.581232219891, 6598.736050557924, 6615.503837212132, 6621.073049773132, 6658.866822663616, 6778.728850846108, 6788.185417749704, 6810.31896810315, 6818.215905170969, 6835.58986460814, 6654.968479885625, 6656.5340426169705, 6658.700358483783, 6659.766908158192, 6676.632785196666], "unit": "score", "name": "prototype.html", "value": 4939.142318895902}, {"lowerIsBetter": false, "replicates": [812.9634166462512, 816.3346872299076, 822.564041058239, 826.9609186240565, 855.6577369052383, 13960.930195349034, 13983.440662373492, 14045.719085618282, 14116.999999999975, 14149.999999999987, 11748.177627566074, 12575.874241257585, 12990.28553429561, 13029.934850325759, 13104.606861794162, 814.8044469327364, 829.8838162657232, 830.767385132164, 834.6452757578036, 836.6444261189001, 828.3662997806653, 833.6415341403194, 834.5827086456771, 835.3275613131427, 837.1753822484848, 862.5213006781233, 867.4751775176022, 871.024452613071, 871.7515508080198, 872.1627237851638, 866.2420382165606, 866.4801119328447, 867.5792240763225, 867.895852497698, 868.2836659755727, 632.6963057732269, 638.594492497263, 638.8498702804837, 639.0, 642.1555654314608, 13347.666308342272, 13378.39797209128, 13397.0, 13411.195328280237, 13433.39549720265, 13390.129641573267, 13483.528076517276, 13645.249511276876, 13698.863011369858, 13703.383347749375, 10024.448655323955, 10514.21143414247, 10563.841542376793, 10674.0, 11176.944115279453, 3641.1261297288725, 3643.198496330803, 3665.8900232992787, 3674.669279764834, 3776.9055773605605, 49269.507304926854, 50106.999999999636, 50712.23931641028, 50815.491845081444, 50868.23697644538, 10311.48442577868, 10398.220133490018, 10430.322029068086, 10546.41994690284, 10550.736231594117, 18034.27862885496, 18041.368552100612, 18083.819161808213, 18116.275348986157, 18121.818781812013, 7523.172451030382, 7618.923810761821, 7621.771346859603, 7694.923050769533, 7828.178041305581, 4210.368444733253, 4297.355396690459, 4315.331123675835, 4355.912881742411, 4440.467143942683, 3098.7366073883973, 3135.1691801672573, 3145.9842700786808, 3154.794938329047, 3168.98415507921, 575.9654420734769, 584.9122631605293, 592.8221533539921, 593.1221791748237, 604.7460066771879, 681.4854784637566, 687.3470203306879, 697.5709938387956, 710.1726488640779, 712.3659942651045, 8197.46716463428, 8880.822383552293, 8913.509756963429, 9030.819383612292, 9075.54622268897, 568.8919105369966, 569.9458551437607, 595.9314678811905, 669.7050511483512, 714.2607401339588, 4055.7769322687536, 4121.1345617420075, 4212.894677633022, 4255.1915136124035, 4267.97866010668, 56232.718836405555, 57138.714306429036, 57310.42689573051, 57537.71231143901, 57787.711061444425, 49309.0, 49939.0, 50887.7455612727, 51095.7445212779, 51189.74405127951, 46207.53792462032, 46317.0, 47031.0, 47153.29270060952, 47318.29022564664, 8363.707270245512, 8453.535055571756, 8457.196566326189, 8503.574821259035, 8720.302375809793, 34339.313213735084, 34879.0, 35018.0, 35748.4637730429, 35982.8200858994, 39126.0, 39350.2129957405, 41050.58949410468, 43879.561204387544, 44174.55825441833, 10049.899501004897, 10396.0, 10433.530491127765, 10606.575736970435, 10655.680329590125, 11292.548298067984, 11313.321200727984, 11383.601573944872, 11547.4803633835, 12019.75960480803, 10717.839232411365, 10978.945105274423, 11003.17476189305, 11163.279572824416, 11246.1565382595, 10453.581856725647, 10724.517396717323, 10762.569497220024, 10773.0, 10795.514201861091, 9992.250581206294, 10008.549615267184, 10029.398236105857, 10034.0, 10051.949740251252, 8088.595570221583, 8360.372972027, 8374.371922105745, 8378.287845533197, 8505.532195729294, 8586.367582346447, 8613.353998450266, 8761.773351730635, 8780.273797772588, 9125.45247285165], "unit": "score", "name": "yui.html", "value": 6292.942358266636}], "name": "dromaeo_css", "value": 6789.71985994362}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 108.0, 115.0, 112.0, 113.0, 124.0, 112.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.3}, {"lowerIsBetter": true, "replicates": [157.0, 130.0, 151.0, 174.0, 128.0, 158.0, 150.0, 136.0, 172.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 162.0, 163.0, 162.0, 162.0, 163.0, 171.0, 167.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.8}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 72.0, 75.0, 73.0, 130.0, 75.0, 72.0, 82.0, 74.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 147.0, 95.0, 96.0, 97.0, 142.0, 95.0, 96.0, 148.0], "unit": "score", "name": "audio-oscillator", "value": 110.6}, {"lowerIsBetter": true, "replicates": [122.0, 116.0, 115.0, 116.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [56.0, 55.0, 56.0, 55.0, 58.0, 57.0, 57.0, 63.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 68.0, 68.0, 70.0, 68.0, 67.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [84.0, 85.0, 96.0, 85.0, 84.0, 92.0, 84.0, 83.0, 85.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [119.0, 127.0, 123.0, 128.0, 120.0, 117.0, 119.0, 117.0, 121.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [145.0, 151.0, 155.0, 152.0, 158.0, 143.0, 144.0, 152.0, 151.0, 148.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 70.0, 70.0, 74.0, 70.0, 69.0, 69.0, 67.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1525.9000000000003}]} 13:16:59 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1525.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6789.72"}}} 13:16:59 INFO - Return code: 0 13:17:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:17:00 ERROR - # TBPL SUCCESS # 13:17:00 INFO - Running post-action listener: _resource_record_post_action 13:17:00 INFO - Running post-run listener: _resource_record_post_run 13:17:01 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 10584064; Write bytes: 470388736; Read time: 3460; Write time: 520080 13:17:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 32063488; Read time: 0; Write time: 40068 13:17:01 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 8695808; Write bytes: 374747136; Read time: 3040; Write time: 404192 13:17:01 INFO - Running post-run listener: _upload_blobber_files 13:17:01 INFO - Blob upload gear active. 13:17:01 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:17:01 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:17:01 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-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 13:17:01 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-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 13:17:01 INFO - (blobuploader) - INFO - Open directory for files ... 13:17:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:17:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:17:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:02 INFO - (blobuploader) - INFO - Done attempting. 13:17:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:17:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:17:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:17:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:17:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:17:03 INFO - (blobuploader) - INFO - Done attempting. 13:17:03 INFO - (blobuploader) - INFO - Iteration through files over. 13:17:03 INFO - Return code: 0 13:17:03 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:17:03 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:17:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/38cb5f54e117dc7aa0e80008e32cbd92fd05f4433b4ea4a76427ada6bbecd5f941ef2a559d95cb4de29fb1f45a0e3488d2447d6caa3f8f32452bafc4f5630bff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7870bfde592052aeb9f6afa22711ea8baf9076c250f87b439cd0d5368874db1d1e64c18d5074e3ed7260af2a8d5dd46c1a4a7bd780eef2e075df92d1750ec78f"} 13:17:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:17:03 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:17:03 INFO - Contents: 13:17:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/38cb5f54e117dc7aa0e80008e32cbd92fd05f4433b4ea4a76427ada6bbecd5f941ef2a559d95cb4de29fb1f45a0e3488d2447d6caa3f8f32452bafc4f5630bff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7870bfde592052aeb9f6afa22711ea8baf9076c250f87b439cd0d5368874db1d1e64c18d5074e3ed7260af2a8d5dd46c1a4a7bd780eef2e075df92d1750ec78f"} 13:17:03 INFO - Running post-run listener: copy_logs_to_upload_dir 13:17:03 INFO - Copying logs to upload dir... 13:17:03 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 13:17:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.759772 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-02-28 13:17:03.710250) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-28 13:17:03.713443) ========= 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=41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/38cb5f54e117dc7aa0e80008e32cbd92fd05f4433b4ea4a76427ada6bbecd5f941ef2a559d95cb4de29fb1f45a0e3488d2447d6caa3f8f32452bafc4f5630bff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7870bfde592052aeb9f6afa22711ea8baf9076c250f87b439cd0d5368874db1d1e64c18d5074e3ed7260af2a8d5dd46c1a4a7bd780eef2e075df92d1750ec78f"} build_url:https://queue.taskcluster.net/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/ZQflnwTdSxOxGCdK7KRtdQ/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/38cb5f54e117dc7aa0e80008e32cbd92fd05f4433b4ea4a76427ada6bbecd5f941ef2a559d95cb4de29fb1f45a0e3488d2447d6caa3f8f32452bafc4f5630bff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/7870bfde592052aeb9f6afa22711ea8baf9076c250f87b439cd0d5368874db1d1e64c18d5074e3ed7260af2a8d5dd46c1a4a7bd780eef2e075df92d1750ec78f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-28 13:17:03.738111) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 13:17:03.738448) ========= 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=41bf3e9aed84707956354da8000001c5-1456692023.506915-397884747 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003713 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-28 13:17:03.819678) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-28 13:17:03.819998) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-28 13:17:03.820274) ========= ========= Total master_lag: 0.25 =========