builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1453993812.37 results: success (0) buildid: 20160128043006 builduid: 7c9ab2f1e0974a7994cbd8b3d6506ef9 revision: 0e9213d8a0f843b514bed40d7f163843a9d71989 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:12.370749) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:12.371218) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:12.371536) ========= 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=d2a8c569965ab8367867b893000001a1-1453993716.460711-66607391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006369 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:12.394799) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:12.395098) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:12.415687) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:12.415957) ========= 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=d2a8c569965ab8367867b893000001a1-1453993716.460711-66607391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:12.463969) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:12.464252) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:12.464637) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:12.464918) ========= 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=d2a8c569965ab8367867b893000001a1-1453993716.460711-66607391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-28 07:10:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 64.4M=0s 2016-01-28 07:10:12 (64.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.175802 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:12.653083) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:12.653395) ========= 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=d2a8c569965ab8367867b893000001a1-1453993716.460711-66607391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015905 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:12.703146) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:12.703487) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 0e9213d8a0f843b514bed40d7f163843a9d71989 --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 0e9213d8a0f843b514bed40d7f163843a9d71989 --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=d2a8c569965ab8367867b893000001a1-1453993716.460711-66607391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-28 07:10:12,998 truncating revision to first 12 chars 2016-01-28 07:10:12,998 Setting DEBUG logging. 2016-01-28 07:10:12,998 attempt 1/10 2016-01-28 07:10:12,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/0e9213d8a0f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-28 07:10:13,231 unpacking tar archive at: mozilla-inbound-0e9213d8a0f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528615 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:13.244253) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:13.244600) ========= echo 0e9213d8a0f843b514bed40d7f163843a9d71989 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0e9213d8a0f843b514bed40d7f163843a9d71989'] 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=d2a8c569965ab8367867b893000001a1-1453993716.460711-66607391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 0e9213d8a0f843b514bed40d7f163843a9d71989 program finished with exit code 0 elapsedTime=0.003595 script_repo_revision: '0e9213d8a0f843b514bed40d7f163843a9d71989' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:13.293356) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:13.293675) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-28 07:10:13.304296) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-28 07:10:13.304585) ========= /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=d2a8c569965ab8367867b893000001a1-1453993716.460711-66607391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:10:13 INFO - MultiFileLogger online at 20160128 07:10:13 in /builds/slave/test-pgo 07:10:13 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 07:10:13 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 07:10:13 INFO - {'append_to_log': False, 07:10:13 INFO - 'base_work_dir': '/builds/slave/test-pgo', 07:10:13 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:10:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 07:10:13 INFO - 'branch': 'Mozilla-Inbound', 07:10:13 INFO - 'buildbot_json_path': 'buildprops.json', 07:10:13 INFO - 'config_files': ('talos/linux_config.py',), 07:10:13 INFO - 'default_actions': ('clobber', 07:10:13 INFO - 'read-buildbot-config', 07:10:13 INFO - 'download-and-extract', 07:10:13 INFO - 'populate-webroot', 07:10:13 INFO - 'create-virtualenv', 07:10:13 INFO - 'install', 07:10:13 INFO - 'run-tests'), 07:10:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:10:13 INFO - 'download_minidump_stackwalk': True, 07:10:13 INFO - 'download_symbols': 'ondemand', 07:10:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:10:13 INFO - 'tooltool.py': '/tools/tooltool.py', 07:10:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:10:13 INFO - '/tools/misc-python/virtualenv.py')}, 07:10:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:10:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:10:13 INFO - 'installer_path': 'installer.exe', 07:10:13 INFO - 'log_level': 'info', 07:10:13 INFO - 'log_name': 'talos', 07:10:13 INFO - 'log_to_console': True, 07:10:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:10:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:10:13 INFO - 'opt_config_files': (), 07:10:13 INFO - 'pip_index': False, 07:10:13 INFO - 'sps_profile': False, 07:10:13 INFO - 'sps_profile_interval': 0, 07:10:13 INFO - 'suite': 'dromaeojs-e10s', 07:10:13 INFO - 'system_bits': '32', 07:10:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:10:13 INFO - 'title': 'talos-linux64-ix-043', 07:10:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:10:13 INFO - 'use_talos_json': True, 07:10:13 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 07:10:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:10:13 INFO - 'work_dir': 'build'} 07:10:13 INFO - ##### 07:10:13 INFO - ##### Running clobber step. 07:10:13 INFO - ##### 07:10:13 INFO - Running pre-action listener: _resource_record_pre_action 07:10:13 INFO - Running main action method: clobber 07:10:13 INFO - rmtree: /builds/slave/test-pgo/build 07:10:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 07:10:14 INFO - Running post-action listener: _resource_record_post_action 07:10:14 INFO - ##### 07:10:14 INFO - ##### Running read-buildbot-config step. 07:10:14 INFO - ##### 07:10:14 INFO - Running pre-action listener: _resource_record_pre_action 07:10:14 INFO - Running main action method: read_buildbot_config 07:10:14 INFO - Using buildbot properties: 07:10:14 INFO - { 07:10:14 INFO - "project": "", 07:10:14 INFO - "product": "firefox", 07:10:14 INFO - "script_repo_revision": "production", 07:10:14 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:10:14 INFO - "repository": "", 07:10:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:10:14 INFO - "buildid": "20160128043006", 07:10:14 INFO - "pgo_build": "True", 07:10:14 INFO - "basedir": "/builds/slave/test-pgo", 07:10:14 INFO - "buildnumber": 359, 07:10:14 INFO - "slavename": "talos-linux64-ix-043", 07:10:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:10:14 INFO - "platform": "ubuntu64_hw", 07:10:14 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 07:10:14 INFO - "branch": "mozilla-inbound", 07:10:14 INFO - "repo_path": "integration/mozilla-inbound", 07:10:14 INFO - "revision": "0e9213d8a0f843b514bed40d7f163843a9d71989", 07:10:14 INFO - "stage_platform": "linux64-pgo", 07:10:14 INFO - "builduid": "7c9ab2f1e0974a7994cbd8b3d6506ef9", 07:10:14 INFO - "slavebuilddir": "test" 07:10:14 INFO - } 07:10:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2. 07:10:14 INFO - Running post-action listener: _resource_record_post_action 07:10:14 INFO - ##### 07:10:14 INFO - ##### Running download-and-extract step. 07:10:14 INFO - ##### 07:10:14 INFO - Running pre-action listener: _resource_record_pre_action 07:10:14 INFO - Running main action method: download_and_extract 07:10:14 INFO - mkdir: /builds/slave/test-pgo/build/tests 07:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:14 INFO - https://queue.taskcluster.net/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:10:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/test_packages.json 07:10:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/test_packages.json 07:10:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 07:10:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 07:10:15 INFO - Downloaded 1448 bytes. 07:10:15 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 07:10:15 INFO - Using the following test package requirements: 07:10:15 INFO - {u'common': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 07:10:15 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:10:15 INFO - u'gtest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:10:15 INFO - u'jittest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:15 INFO - u'jsshell-linux-x86_64.zip'], 07:10:15 INFO - u'mochitest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:10:15 INFO - u'mozbase': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 07:10:15 INFO - u'reftest': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:10:15 INFO - u'talos': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:10:15 INFO - u'web-platform': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:10:15 INFO - u'webapprt': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'], 07:10:15 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip', 07:10:15 INFO - u'firefox-47.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:10:15 INFO - Downloading packages: [u'firefox-47.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:15 INFO - https://queue.taskcluster.net/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:10:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:10:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:10:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/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 07:10:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/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 07:10:16 INFO - Downloaded 22547351 bytes. 07:10:16 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'] 07:10:16 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 07:10:18 INFO - Return code: 0 07:10:18 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 07:10:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:18 INFO - https://queue.taskcluster.net/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:10:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:10:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.common.tests.zip 07:10:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/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 07:10:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/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 07:10:20 INFO - Downloaded 22547351 bytes. 07:10:20 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'] 07:10:20 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 07:10:22 INFO - Return code: 0 07:10:22 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')]} 07:10:22 INFO - https://queue.taskcluster.net/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:10:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 07:10:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.talos.tests.zip 07:10:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/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 07:10:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/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 07:10:23 INFO - Downloaded 10706587 bytes. 07:10:23 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'] 07:10:23 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 07:10:23 INFO - Return code: 0 07:10: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')]} 07:10:23 INFO - https://queue.taskcluster.net/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:10:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:10:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:10:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/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 07:10:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/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 07:10:24 INFO - Downloaded 56035915 bytes. 07:10:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:10:24 INFO - mkdir: /builds/slave/test-pgo/properties 07:10:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 07:10:24 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 07:10:24 INFO - Contents: 07:10:24 INFO - build_url:https://queue.taskcluster.net/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 07:10:24 INFO - Running post-action listener: _resource_record_post_action 07:10:24 INFO - Running post-action listener: set_extra_try_arguments 07:10:24 INFO - ##### 07:10:24 INFO - ##### Running populate-webroot step. 07:10:24 INFO - ##### 07:10:24 INFO - Running pre-action listener: _resource_record_pre_action 07:10:24 INFO - Running main action method: populate_webroot 07:10:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:10:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:10:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:10:24 INFO - '--tppagecycles', 07:10:24 INFO - '7'], 07:10:24 INFO - 'tests': ['tsvgm']}}, 07:10:24 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:10:24 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:10:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:10:24 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:10:24 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:10:24 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:10:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:24 INFO - 'talos_options': ['--e10s'], 07:10:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:10:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:24 INFO - 'tests': ['damp', 'tps']}, 07:10:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:24 INFO - 'talos_options': ['--e10s'], 07:10:24 INFO - 'tests': ['damp', 'tps']}, 07:10:24 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:10:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:10:24 INFO - 'other': {'tests': ['a11yr', 07:10:24 INFO - 'ts_paint', 07:10:24 INFO - 'tpaint', 07:10:24 INFO - 'sessionrestore', 07:10:24 INFO - 'sessionrestore_no_auto_restore']}, 07:10:24 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:10:24 INFO - 'tests': ['a11yr', 07:10:24 INFO - 'ts_paint', 07:10:24 INFO - 'tpaint', 07:10:24 INFO - 'sessionrestore', 07:10:24 INFO - 'sessionrestore_no_auto_restore']}, 07:10:24 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:10:24 INFO - 'tests': ['a11yr', 07:10:24 INFO - 'ts_paint', 07:10:24 INFO - 'tpaint', 07:10:24 INFO - 'sessionrestore', 07:10:24 INFO - 'sessionrestore_no_auto_restore']}, 07:10:24 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:10:24 INFO - 'tests': ['a11yr', 07:10:24 INFO - 'ts_paint', 07:10:24 INFO - 'tpaint', 07:10:24 INFO - 'sessionrestore', 07:10:24 INFO - 'sessionrestore_no_auto_restore']}, 07:10:24 INFO - 'other_l64': {'tests': ['a11yr', 07:10:24 INFO - 'ts_paint', 07:10:24 INFO - 'tpaint', 07:10:24 INFO - 'sessionrestore', 07:10:24 INFO - 'sessionrestore_no_auto_restore']}, 07:10:24 INFO - 'other_nol64': {'tests': ['a11yr', 07:10:24 INFO - 'ts_paint', 07:10:24 INFO - 'tpaint', 07:10:24 INFO - 'sessionrestore', 07:10:24 INFO - 'sessionrestore_no_auto_restore']}, 07:10:24 INFO - 'svgr': {'tests': ['tsvgx', 07:10:24 INFO - 'tsvgr_opacity', 07:10:24 INFO - 'tart', 07:10:24 INFO - 'tscrollx', 07:10:24 INFO - 'cart']}, 07:10:24 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:10:24 INFO - 'tests': ['tsvgx', 07:10:24 INFO - 'tsvgr_opacity', 07:10:24 INFO - 'tart', 07:10:24 INFO - 'tscrollx', 07:10:24 INFO - 'cart']}, 07:10:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:24 INFO - 'tests': ['tp5o']}, 07:10:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:24 INFO - 'talos_options': ['--e10s'], 07:10:24 INFO - 'tests': ['tp5o']}, 07:10:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:24 INFO - 'talos_options': ['--xperf_path', 07:10:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:24 INFO - 'tests': ['tp5n']}, 07:10:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:10:24 INFO - 'talos_options': ['--e10s', 07:10:24 INFO - '--xperf_path', 07:10:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:10:24 INFO - 'tests': ['tp5n']}}, 07:10:24 INFO - 'talos.zip': {'path': '', 07:10:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:10:24 INFO - Running post-action listener: _resource_record_post_action 07:10:24 INFO - ##### 07:10:24 INFO - ##### Running create-virtualenv step. 07:10:24 INFO - ##### 07:10:24 INFO - Running pre-action listener: _resource_record_pre_action 07:10:24 INFO - Running main action method: create_virtualenv 07:10:24 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 07:10:24 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 07:10:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 07:10:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:10:24 INFO - Using real prefix '/usr' 07:10:24 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 07:10:25 INFO - Installing distribute.............................................................................................................................................................................................done. 07:10:27 INFO - Installing pip.................done. 07:10:27 INFO - Return code: 0 07:10:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 07:10:27 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')]} 07:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:27 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')]} 07:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:27 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 0x7f6a7f652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2171740>, '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 0x2172640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2172af0>, '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': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', '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 07:10:27 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 07:10:27 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 07:10:27 INFO - Using env: {'DISPLAY': ':0', 07:10:27 INFO - 'HOME': '/home/cltbld', 07:10:27 INFO - 'LANG': 'en_US.UTF-8', 07:10:27 INFO - 'LANGUAGE': 'en_US:en', 07:10:27 INFO - 'LOGNAME': 'cltbld', 07:10:27 INFO - 'MAIL': '/var/mail/cltbld', 07:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:27 INFO - 'MOZ_NO_REMOTE': '1', 07:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:27 INFO - 'NO_EM_RESTART': '1', 07:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:10:27 INFO - 'PWD': '/builds/slave/test-pgo', 07:10:27 INFO - 'SHELL': '/bin/bash', 07:10:27 INFO - 'SHLVL': '1', 07:10:27 INFO - 'TERM': 'linux', 07:10:27 INFO - 'TMOUT': '86400', 07:10:27 INFO - 'USER': 'cltbld', 07:10:27 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', 07:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:27 INFO - '_': '/tools/buildbot/bin/python'} 07:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:27 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 07:10:27 INFO - Cleaning up... 07:10:27 INFO - Return code: 0 07:10:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 07:10:27 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')]} 07:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:27 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')]} 07:10:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:27 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 0x7f6a7f652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2171740>, '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 0x2172640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2172af0>, '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': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', '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 07:10:27 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 07:10:27 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 07:10:27 INFO - Using env: {'DISPLAY': ':0', 07:10:27 INFO - 'HOME': '/home/cltbld', 07:10:27 INFO - 'LANG': 'en_US.UTF-8', 07:10:27 INFO - 'LANGUAGE': 'en_US:en', 07:10:27 INFO - 'LOGNAME': 'cltbld', 07:10:27 INFO - 'MAIL': '/var/mail/cltbld', 07:10:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:27 INFO - 'MOZ_NO_REMOTE': '1', 07:10:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:27 INFO - 'NO_EM_RESTART': '1', 07:10:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:10:27 INFO - 'PWD': '/builds/slave/test-pgo', 07:10:27 INFO - 'SHELL': '/bin/bash', 07:10:27 INFO - 'SHLVL': '1', 07:10:27 INFO - 'TERM': 'linux', 07:10:27 INFO - 'TMOUT': '86400', 07:10:27 INFO - 'USER': 'cltbld', 07:10:27 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', 07:10:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:27 INFO - '_': '/tools/buildbot/bin/python'} 07:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:27 INFO - Downloading/unpacking psutil>=0.7.1 07:10:27 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 07:10:27 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 07:10:27 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 07:10:27 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 07:10:27 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 07:10:27 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 07:10:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 07:10:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:29 INFO - Installing collected packages: psutil 07:10:29 INFO - Running setup.py install for psutil 07:10:29 INFO - building 'psutil._psutil_linux' extension 07:10:29 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 07:10:29 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 07:10:29 INFO - building 'psutil._psutil_posix' extension 07:10:29 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 07:10:29 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 07:10:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:10:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:10:29 INFO - Successfully installed psutil 07:10:29 INFO - Cleaning up... 07:10:29 INFO - Return code: 0 07:10:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 07:10:29 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')]} 07:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:29 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')]} 07:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:29 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 0x7f6a7f652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2171740>, '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 0x2172640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2172af0>, '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': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', '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 07:10:29 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 07:10:29 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 07:10:29 INFO - Using env: {'DISPLAY': ':0', 07:10:29 INFO - 'HOME': '/home/cltbld', 07:10:29 INFO - 'LANG': 'en_US.UTF-8', 07:10:29 INFO - 'LANGUAGE': 'en_US:en', 07:10:29 INFO - 'LOGNAME': 'cltbld', 07:10:29 INFO - 'MAIL': '/var/mail/cltbld', 07:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:29 INFO - 'MOZ_NO_REMOTE': '1', 07:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:29 INFO - 'NO_EM_RESTART': '1', 07:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:10:29 INFO - 'PWD': '/builds/slave/test-pgo', 07:10:29 INFO - 'SHELL': '/bin/bash', 07:10:29 INFO - 'SHLVL': '1', 07:10:29 INFO - 'TERM': 'linux', 07:10:29 INFO - 'TMOUT': '86400', 07:10:29 INFO - 'USER': 'cltbld', 07:10:29 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', 07:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:29 INFO - '_': '/tools/buildbot/bin/python'} 07:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:30 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:10:30 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 07:10:30 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 07:10:30 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 07:10:30 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 07:10:30 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 07:10:30 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 07:10:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:10:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:10:32 INFO - Installing collected packages: mozsystemmonitor 07:10:32 INFO - Running setup.py install for mozsystemmonitor 07:10:32 INFO - Successfully installed mozsystemmonitor 07:10:32 INFO - Cleaning up... 07:10:32 INFO - Return code: 0 07:10:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 07:10:32 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')]} 07:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:32 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')]} 07:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:32 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 0x7f6a7f652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2171740>, '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 0x2172640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2172af0>, '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': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', '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 07:10:32 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 07:10:32 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 07:10:32 INFO - Using env: {'DISPLAY': ':0', 07:10:32 INFO - 'HOME': '/home/cltbld', 07:10:32 INFO - 'LANG': 'en_US.UTF-8', 07:10:32 INFO - 'LANGUAGE': 'en_US:en', 07:10:32 INFO - 'LOGNAME': 'cltbld', 07:10:32 INFO - 'MAIL': '/var/mail/cltbld', 07:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:32 INFO - 'MOZ_NO_REMOTE': '1', 07:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:32 INFO - 'NO_EM_RESTART': '1', 07:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:10:32 INFO - 'PWD': '/builds/slave/test-pgo', 07:10:32 INFO - 'SHELL': '/bin/bash', 07:10:32 INFO - 'SHLVL': '1', 07:10:32 INFO - 'TERM': 'linux', 07:10:32 INFO - 'TMOUT': '86400', 07:10:32 INFO - 'USER': 'cltbld', 07:10:32 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', 07:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:32 INFO - '_': '/tools/buildbot/bin/python'} 07:10:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:32 INFO - Downloading/unpacking blobuploader==1.2.4 07:10:32 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 07:10:32 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 07:10:32 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 07:10:32 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 07:10:32 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 07:10:32 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 07:10:34 INFO - Downloading blobuploader-1.2.4.tar.gz 07:10:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:10:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:10:34 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 07:10:34 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 07:10:34 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 07:10:34 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 07:10:34 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 07:10:34 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 07:10:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 07:10:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:10:34 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 07:10:34 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 07:10:34 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 07:10:34 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 07:10:34 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 07:10:34 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 07:10:34 INFO - Downloading docopt-0.6.1.tar.gz 07:10:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 07:10:34 INFO - Installing collected packages: blobuploader, requests, docopt 07:10:34 INFO - Running setup.py install for blobuploader 07:10:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:10:35 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 07:10:35 INFO - Running setup.py install for requests 07:10:35 INFO - Running setup.py install for docopt 07:10:35 INFO - Successfully installed blobuploader requests docopt 07:10:35 INFO - Cleaning up... 07:10:35 INFO - Return code: 0 07:10:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:35 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 0x7f6a7f652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2171740>, '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 0x2172640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2172af0>, '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': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', '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 07:10:35 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 07:10:35 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 07:10:35 INFO - Using env: {'DISPLAY': ':0', 07:10:35 INFO - 'HOME': '/home/cltbld', 07:10:35 INFO - 'LANG': 'en_US.UTF-8', 07:10:35 INFO - 'LANGUAGE': 'en_US:en', 07:10:35 INFO - 'LOGNAME': 'cltbld', 07:10:35 INFO - 'MAIL': '/var/mail/cltbld', 07:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:35 INFO - 'MOZ_NO_REMOTE': '1', 07:10:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:35 INFO - 'NO_EM_RESTART': '1', 07:10:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:10:35 INFO - 'PWD': '/builds/slave/test-pgo', 07:10:35 INFO - 'SHELL': '/bin/bash', 07:10:35 INFO - 'SHLVL': '1', 07:10:35 INFO - 'TERM': 'linux', 07:10:35 INFO - 'TMOUT': '86400', 07:10:35 INFO - 'USER': 'cltbld', 07:10:35 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', 07:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:35 INFO - '_': '/tools/buildbot/bin/python'} 07:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:10:35 INFO - Running setup.py (path:/tmp/pip-4jmIQ6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:10:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:10:35 INFO - Running setup.py (path:/tmp/pip-tgU47q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:10:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:10:35 INFO - Running setup.py (path:/tmp/pip-N5J13o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:10:35 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:10:35 INFO - Running setup.py (path:/tmp/pip-D5AQdr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:10:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:10:36 INFO - Running setup.py (path:/tmp/pip-kTpCxH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:10:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:10:36 INFO - Running setup.py (path:/tmp/pip-wWuV6j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:10:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:10:36 INFO - Running setup.py (path:/tmp/pip-oBb9T2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:10:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:10:36 INFO - Running setup.py (path:/tmp/pip-R9_qRG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:10:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:10:36 INFO - Running setup.py (path:/tmp/pip-6Fwd3m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:10:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:10:36 INFO - Running setup.py (path:/tmp/pip-2AiaWs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:10:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:10:36 INFO - Running setup.py (path:/tmp/pip-vFIpDi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:10:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:10:36 INFO - Running setup.py (path:/tmp/pip-D7GeEm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:10:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:10:36 INFO - Running setup.py (path:/tmp/pip-Vbb_3O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:10:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:10:36 INFO - Running setup.py (path:/tmp/pip-ePhLEx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:10:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:10:36 INFO - Running setup.py (path:/tmp/pip-9Qu8w2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:10:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:10:36 INFO - Running setup.py (path:/tmp/pip-LXmHQz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:10:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:10:36 INFO - Running setup.py (path:/tmp/pip-Amd8nI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:10:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:10:36 INFO - Running setup.py install for manifestparser 07:10:37 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 07:10:37 INFO - Running setup.py install for mozcrash 07:10:37 INFO - Running setup.py install for mozdebug 07:10:37 INFO - Running setup.py install for mozdevice 07:10:37 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 07:10:37 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 07:10:37 INFO - Running setup.py install for mozfile 07:10:37 INFO - Running setup.py install for mozhttpd 07:10:37 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 07:10:37 INFO - Running setup.py install for mozinfo 07:10:37 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 07:10:37 INFO - Running setup.py install for mozInstall 07:10:37 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 07:10:37 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 07:10:37 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 07:10:37 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 07:10:37 INFO - Running setup.py install for mozleak 07:10:37 INFO - Running setup.py install for mozlog 07:10:37 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 07:10:38 INFO - Running setup.py install for moznetwork 07:10:38 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 07:10:38 INFO - Running setup.py install for mozprocess 07:10:38 INFO - Running setup.py install for mozprofile 07:10:38 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 07:10:38 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 07:10:38 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 07:10:38 INFO - Running setup.py install for mozrunner 07:10:38 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 07:10:38 INFO - Running setup.py install for mozscreenshot 07:10:38 INFO - Running setup.py install for moztest 07:10:38 INFO - Running setup.py install for mozversion 07:10:38 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 07:10:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:10:38 INFO - Cleaning up... 07:10:38 INFO - Return code: 0 07:10:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:10: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')]} 07:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10: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')]} 07:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:38 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 0x7f6a7f652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2171740>, '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 0x2172640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2172af0>, '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': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', '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 07:10:38 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 07:10:38 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 07:10:38 INFO - Using env: {'DISPLAY': ':0', 07:10:38 INFO - 'HOME': '/home/cltbld', 07:10:38 INFO - 'LANG': 'en_US.UTF-8', 07:10:38 INFO - 'LANGUAGE': 'en_US:en', 07:10:38 INFO - 'LOGNAME': 'cltbld', 07:10:38 INFO - 'MAIL': '/var/mail/cltbld', 07:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:38 INFO - 'MOZ_NO_REMOTE': '1', 07:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:38 INFO - 'NO_EM_RESTART': '1', 07:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:10:38 INFO - 'PWD': '/builds/slave/test-pgo', 07:10:38 INFO - 'SHELL': '/bin/bash', 07:10:38 INFO - 'SHLVL': '1', 07:10:38 INFO - 'TERM': 'linux', 07:10:38 INFO - 'TMOUT': '86400', 07:10:38 INFO - 'USER': 'cltbld', 07:10:38 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', 07:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:38 INFO - '_': '/tools/buildbot/bin/python'} 07:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:10:38 INFO - Running setup.py (path:/tmp/pip-OLL7Qt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 07:10:39 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)) 07:10:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:10:39 INFO - Running setup.py (path:/tmp/pip-gP9Jl7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 07:10:39 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)) 07:10:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:10:39 INFO - Running setup.py (path:/tmp/pip-LlKAqL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 07:10:39 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)) 07:10:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:10:39 INFO - Running setup.py (path:/tmp/pip-Z4A3th-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 07:10:39 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)) 07:10:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 07:10:39 INFO - Running setup.py (path:/tmp/pip-MbyRGY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 07:10:39 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)) 07:10:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:10:39 INFO - Running setup.py (path:/tmp/pip-g0PJgA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 07:10:39 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)) 07:10:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:10:39 INFO - Running setup.py (path:/tmp/pip-vW4u0P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 07:10:39 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)) 07:10:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:10:39 INFO - Running setup.py (path:/tmp/pip-HdWxLZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 07:10:39 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)) 07:10:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 07:10:39 INFO - Running setup.py (path:/tmp/pip-e_klvK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 07:10:39 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)) 07:10:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 07:10:39 INFO - Running setup.py (path:/tmp/pip-OvIse0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 07:10:39 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)) 07:10:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:10:39 INFO - Running setup.py (path:/tmp/pip-0Uh8n6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 07:10:39 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)) 07:10:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:10:39 INFO - Running setup.py (path:/tmp/pip-B0h8Rf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 07:10:39 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)) 07:10:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:10:39 INFO - Running setup.py (path:/tmp/pip-ghfoAT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 07:10:39 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)) 07:10:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:10:39 INFO - Running setup.py (path:/tmp/pip-9ElJiV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 07:10:40 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)) 07:10:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:10:40 INFO - Running setup.py (path:/tmp/pip-hhZINk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 07:10:40 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)) 07:10:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 07:10:40 INFO - Running setup.py (path:/tmp/pip-yU6mjx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 07:10:40 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)) 07:10:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 07:10:40 INFO - Running setup.py (path:/tmp/pip-QuYHKZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 07:10:40 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)) 07:10:40 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)) 07:10:40 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)) 07:10:40 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)) 07:10:40 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)) 07:10:40 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)) 07:10:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 07:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:41 INFO - Downloading blessings-1.6.tar.gz 07:10:41 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 07:10:42 INFO - Installing collected packages: blessings 07:10:42 INFO - Running setup.py install for blessings 07:10:42 INFO - Successfully installed blessings 07:10:42 INFO - Cleaning up... 07:10:42 INFO - Return code: 0 07:10:42 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 07:10:42 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:10:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:10:42 INFO - Reading from file tmpfile_stdout 07:10:42 INFO - Current package versions: 07:10:42 INFO - argparse == 1.2.1 07:10:42 INFO - blessings == 1.6 07:10:42 INFO - blobuploader == 1.2.4 07:10:42 INFO - docopt == 0.6.1 07:10:42 INFO - manifestparser == 1.1 07:10:42 INFO - mozInstall == 1.12 07:10:42 INFO - mozcrash == 0.16 07:10:42 INFO - mozdebug == 0.1 07:10:42 INFO - mozdevice == 0.48 07:10:42 INFO - mozfile == 1.2 07:10:42 INFO - mozhttpd == 0.7 07:10:42 INFO - mozinfo == 0.9 07:10:42 INFO - mozleak == 0.1 07:10:42 INFO - mozlog == 3.1 07:10:42 INFO - moznetwork == 0.27 07:10:42 INFO - mozprocess == 0.22 07:10:42 INFO - mozprofile == 0.28 07:10:42 INFO - mozrunner == 6.11 07:10:42 INFO - mozscreenshot == 0.1 07:10:42 INFO - mozsystemmonitor == 0.0 07:10:42 INFO - moztest == 0.7 07:10:42 INFO - mozversion == 1.4 07:10:42 INFO - psutil == 3.1.1 07:10:42 INFO - requests == 1.2.3 07:10:42 INFO - wsgiref == 0.1.2 07:10:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 07:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:42 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 0x7f6a7f652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2171740>, '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 0x2172640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2172af0>, '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': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', '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 07:10:42 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 07:10:42 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 07:10:42 INFO - Using env: {'DISPLAY': ':0', 07:10:42 INFO - 'HOME': '/home/cltbld', 07:10:42 INFO - 'LANG': 'en_US.UTF-8', 07:10:42 INFO - 'LANGUAGE': 'en_US:en', 07:10:42 INFO - 'LOGNAME': 'cltbld', 07:10:42 INFO - 'MAIL': '/var/mail/cltbld', 07:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:42 INFO - 'MOZ_NO_REMOTE': '1', 07:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:42 INFO - 'NO_EM_RESTART': '1', 07:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:10:42 INFO - 'PWD': '/builds/slave/test-pgo', 07:10:42 INFO - 'SHELL': '/bin/bash', 07:10:42 INFO - 'SHLVL': '1', 07:10:42 INFO - 'TERM': 'linux', 07:10:42 INFO - 'TMOUT': '86400', 07:10:42 INFO - 'USER': 'cltbld', 07:10:42 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', 07:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:42 INFO - '_': '/tools/buildbot/bin/python'} 07:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:42 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)) 07:10:42 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)) 07:10:42 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)) 07:10:42 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)) 07:10:42 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)) 07:10:42 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)) 07:10:42 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)) 07:10:42 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)) 07:10:42 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)) 07:10:42 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)) 07:10:42 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)) 07:10:42 INFO - Cleaning up... 07:10:42 INFO - Return code: 0 07:10:42 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 07:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:10:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:42 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 0x7f6a7f652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2171740>, '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 0x2172640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2172af0>, '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': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', '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 07:10:42 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 07:10:42 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 07:10:42 INFO - Using env: {'DISPLAY': ':0', 07:10:42 INFO - 'HOME': '/home/cltbld', 07:10:42 INFO - 'LANG': 'en_US.UTF-8', 07:10:42 INFO - 'LANGUAGE': 'en_US:en', 07:10:42 INFO - 'LOGNAME': 'cltbld', 07:10:42 INFO - 'MAIL': '/var/mail/cltbld', 07:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:42 INFO - 'MOZ_NO_REMOTE': '1', 07:10:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:42 INFO - 'NO_EM_RESTART': '1', 07:10:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:10:42 INFO - 'PWD': '/builds/slave/test-pgo', 07:10:42 INFO - 'SHELL': '/bin/bash', 07:10:42 INFO - 'SHLVL': '1', 07:10:42 INFO - 'TERM': 'linux', 07:10:42 INFO - 'TMOUT': '86400', 07:10:42 INFO - 'USER': 'cltbld', 07:10:42 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', 07:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:42 INFO - '_': '/tools/buildbot/bin/python'} 07:10:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:42 INFO - Downloading/unpacking jsonschema 07:10:42 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 07:10:42 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 07:10:42 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 07:10:42 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 07:10:42 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 07:10:42 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 07:10:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:10:44 INFO - Downloading/unpacking functools32 (from jsonschema) 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10: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 07:10:44 INFO - Downloading functools32-3.2.3-2.tar.gz 07:10:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 07:10:44 INFO - warning: no files found matching '*.txt' 07:10:44 INFO - no previously-included directories found matching 'build' 07:10:44 INFO - no previously-included directories found matching 'dist' 07:10:44 INFO - no previously-included directories found matching '.git*' 07:10:44 INFO - Installing collected packages: jsonschema, functools32 07:10:44 INFO - Running setup.py install for functools32 07:10:44 INFO - warning: no files found matching '*.txt' 07:10:44 INFO - no previously-included directories found matching 'build' 07:10:44 INFO - no previously-included directories found matching 'dist' 07:10:44 INFO - no previously-included directories found matching '.git*' 07:10:45 INFO - Successfully installed jsonschema functools32 07:10:45 INFO - Cleaning up... 07:10:45 INFO - Return code: 0 07:10:45 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 07:10:45 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')]} 07:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:45 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')]} 07:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:10:45 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 0x7f6a7f652f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e2560>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2171740>, '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 0x2172640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2172af0>, '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': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', '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 07:10:45 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 07:10:45 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 07:10:45 INFO - Using env: {'DISPLAY': ':0', 07:10:45 INFO - 'HOME': '/home/cltbld', 07:10:45 INFO - 'LANG': 'en_US.UTF-8', 07:10:45 INFO - 'LANGUAGE': 'en_US:en', 07:10:45 INFO - 'LOGNAME': 'cltbld', 07:10:45 INFO - 'MAIL': '/var/mail/cltbld', 07:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:10:45 INFO - 'MOZ_NO_REMOTE': '1', 07:10:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:10:45 INFO - 'NO_EM_RESTART': '1', 07:10:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:10:45 INFO - 'PWD': '/builds/slave/test-pgo', 07:10:45 INFO - 'SHELL': '/bin/bash', 07:10:45 INFO - 'SHLVL': '1', 07:10:45 INFO - 'TERM': 'linux', 07:10:45 INFO - 'TMOUT': '86400', 07:10:45 INFO - 'USER': 'cltbld', 07:10:45 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', 07:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:10:45 INFO - '_': '/tools/buildbot/bin/python'} 07:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:10:45 INFO - Downloading/unpacking flake8 07:10:45 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 07:10:45 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 07:10:45 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 07:10:45 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 07:10:45 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 07:10:45 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 07:10:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:10:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:10:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:10:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 07:10:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:10:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:10:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:10:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:10:47 INFO - no previously-included directories found matching 'docs/_build' 07:10:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:10:47 INFO - Running setup.py install for pep8 07:10:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:10:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:10:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:10:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:10:47 INFO - no previously-included directories found matching 'docs/_build' 07:10:47 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 07:10:47 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:10:47 INFO - Cleaning up... 07:10:48 INFO - Return code: 0 07:10:48 INFO - Running post-action listener: _resource_record_post_action 07:10:48 INFO - Running post-action listener: _start_resource_monitoring 07:10:48 INFO - Starting resource monitoring. 07:10:48 INFO - ##### 07:10:48 INFO - ##### Running install step. 07:10:48 INFO - ##### 07:10:48 INFO - Running pre-action listener: _resource_record_pre_action 07:10:48 INFO - Running main action method: install 07:10:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 07:10:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 07:10:48 INFO - Reading from file tmpfile_stdout 07:10:48 INFO - Detecting whether we're running mozinstall >=1.0... 07:10:48 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 07:10:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 07:10:48 INFO - Reading from file tmpfile_stdout 07:10:48 INFO - Output received: 07:10:48 INFO - Usage: mozinstall [options] installer 07:10:48 INFO - Options: 07:10:48 INFO - -h, --help show this help message and exit 07:10:48 INFO - -d DEST, --destination=DEST 07:10:48 INFO - Directory to install application into. [default: 07:10:48 INFO - "/builds/slave/test-pgo"] 07:10:48 INFO - --app=APP Application being installed. [default: firefox] 07:10:48 INFO - mkdir: /builds/slave/test-pgo/build/application 07:10:48 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'] 07:10:48 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 07:11:04 INFO - Reading from file tmpfile_stdout 07:11:04 INFO - Output received: 07:11:04 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 07:11:04 INFO - Running post-action listener: _resource_record_post_action 07:11:04 INFO - ##### 07:11:04 INFO - ##### Running run-tests step. 07:11:04 INFO - ##### 07:11:04 INFO - Running pre-action listener: _resource_record_pre_action 07:11:04 INFO - Running main action method: run_tests 07:11:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 07:11:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 07:11:04 INFO - Python 2.7.3 07:11:04 INFO - Return code: 0 07:11:04 INFO - grabbing minidump binary from tooltool 07:11: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')]} 07:11:04 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 0x2171740>, '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 0x2172640>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2172af0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 07:11:04 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 07:11:04 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 07:11:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:11:04 INFO - Return code: 0 07:11:04 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 07:11:04 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 07:11:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 07:11:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 07:11:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 07:11:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 07:11:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 07:11:05 INFO - Return code: 0 07:11:05 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/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 07:11:05 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/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 07:11:05 INFO - Using env: {'DISPLAY': ':0', 07:11:05 INFO - 'HOME': '/home/cltbld', 07:11:05 INFO - 'LANG': 'en_US.UTF-8', 07:11:05 INFO - 'LANGUAGE': 'en_US:en', 07:11:05 INFO - 'LOGNAME': 'cltbld', 07:11:05 INFO - 'MAIL': '/var/mail/cltbld', 07:11:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:11:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 07:11:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:11:05 INFO - 'MOZ_NO_REMOTE': '1', 07:11:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 07:11:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:11:05 INFO - 'NO_EM_RESTART': '1', 07:11:05 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:11:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 07:11:05 INFO - 'PWD': '/builds/slave/test-pgo', 07:11:05 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 07:11:05 INFO - 'SHELL': '/bin/bash', 07:11:05 INFO - 'SHLVL': '1', 07:11:05 INFO - 'TERM': 'linux', 07:11:05 INFO - 'TMOUT': '86400', 07:11:05 INFO - 'USER': 'cltbld', 07:11:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1453993716.460711-66607391', 07:11:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:11:05 INFO - '_': '/tools/buildbot/bin/python'} 07:11:05 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/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 07:11:05 INFO - mozversion application_buildid: 20160128043006 07:11:05 INFO - mozversion application_changeset: 0e9213d8a0f843b514bed40d7f163843a9d71989 07:11:05 INFO - mozversion application_display_name: Nightly 07:11:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:11:05 INFO - mozversion application_name: Firefox 07:11:05 INFO - mozversion application_remotingname: firefox 07:11:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:11:05 INFO - mozversion application_vendor: Mozilla 07:11:05 INFO - mozversion application_version: 47.0a1 07:11:05 INFO - mozversion platform_buildid: 20160128043006 07:11:05 INFO - mozversion platform_changeset: 0e9213d8a0f843b514bed40d7f163843a9d71989 07:11:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:11:05 INFO - mozversion platform_version: 47.0a1 07:11:05 INFO - using testdate: 1453993865 07:11:05 INFO - actual date: 1453993865 07:11:05 INFO - starting webserver on 'localhost:34614' 07:11:05 INFO - SUITE-START | Running 3 tests 07:11:05 INFO - TEST-START | dromaeo_css 07:11:05 INFO - operating with platform_type : linux_ 07:11:05 INFO - Initialising browser for dromaeo_css test... 07:11:05 INFO - TEST-INFO | started process 25249 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8bk1hL/profile http://localhost:34614/getInfo.html) 07:11:09 INFO - PROCESS | 25249 | 07:11:09 INFO - PROCESS | 25249 | (process:25332): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:11:10 INFO - PROCESS | 25249 | __metrics Screen width/height:1600/1200 07:11:10 INFO - PROCESS | 25249 | colorDepth:24 07:11:10 INFO - PROCESS | 25249 | Browser inner width/height: 1024/697 07:11:10 INFO - PROCESS | 25249 | __metrics 07:11:10 INFO - PROCESS | 25249 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:11:11 INFO - TEST-INFO | 25249: exit 0 07:11:11 INFO - Browser initialized. 07:11:11 INFO - Running cycle 1/1 for dromaeo_css test... 07:11:11 INFO - TEST-INFO | started process 25382 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp8bk1hL/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:11:12 INFO - PROCESS | 25382 | 07:11:12 INFO - PROCESS | 25382 | (process:25438): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:11:23 INFO - PROCESS | 25382 | RSS: Main: 151412736 07:11:23 INFO - PROCESS | 25382 | 07:12:13 INFO - PROCESS | 25382 | 1453993933070 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] 07:14:21 INFO - PROCESS | 25382 | Cycle 1(1): loaded http://localhost:34614/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34614/tests/dromaeo/cssquery-ext.html) 07:14:22 INFO - PROCESS | 25382 | RSS: Main: 161202176 07:14:22 INFO - PROCESS | 25382 | 07:17:24 INFO - PROCESS | 25382 | Cycle 1(1): loaded http://localhost:34614/tests/dromaeo/cssquery-ext.html (next: http://localhost:34614/tests/dromaeo/cssquery-jquery.html) 07:17:25 INFO - PROCESS | 25382 | RSS: Main: 156499968 07:17:25 INFO - PROCESS | 25382 | 07:20:26 INFO - PROCESS | 25382 | Cycle 1(1): loaded http://localhost:34614/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34614/tests/dromaeo/cssquery-mootools.html) 07:20:27 INFO - PROCESS | 25382 | RSS: Main: 157163520 07:20:27 INFO - PROCESS | 25382 | 07:23:29 INFO - PROCESS | 25382 | Cycle 1(1): loaded http://localhost:34614/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34614/tests/dromaeo/cssquery-prototype.html) 07:23:29 INFO - PROCESS | 25382 | RSS: Main: 155181056 07:23:29 INFO - PROCESS | 25382 | 07:26:32 INFO - PROCESS | 25382 | Cycle 1(1): loaded http://localhost:34614/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34614/tests/dromaeo/cssquery-yui.html) 07:26:32 INFO - PROCESS | 25382 | RSS: Main: 155291648 07:26:32 INFO - PROCESS | 25382 | 07:29:35 INFO - PROCESS | 25382 | Cycle 1(1): loaded http://localhost:34614/tests/dromaeo/cssquery-yui.html (next: http://localhost:34614/tests/dromaeo/cssquery-dojo.html) 07:29:35 INFO - PROCESS | 25382 | RSS: Main: 159309824 07:29:35 INFO - PROCESS | 25382 | 07:29:35 INFO - PROCESS | 25382 | __start_tp_report 07:29:35 INFO - PROCESS | 25382 | _x_x_mozilla_page_load 07:29:35 INFO - PROCESS | 25382 | _x_x_mozilla_page_load_details 07:29:35 INFO - PROCESS | 25382 | |i|pagename|runs| 07:29:35 INFO - PROCESS | 25382 | |0;dojo.html;3129.530570414436;3177.5233714942765;3183.936321273575;3187.7609179311544;3221.581194444722;5103.591712662987;5212.21816727491;5223.555997740187;5243.711595862231;5281.445448227938;5079.466656001122;5189.740512974355;5275.446078161795;5309.522143007129;5321.840344789663;4739.502352253024;4813.78337974792;4830.661853670227;4834.879128021792;4922.581580565657;4825.010872771073;4833.275008748698;4843.104025755247;4904.337914381548;4960.627952903528;4674.509176536449;4737.50256223095;4756;4831.613470922318;4862.246351815475;4769.570738633505;4770.904581908342;4770.95229047712;4786.593139583139;4803.3035209894715;4697.600703940135;4758.524147585248;4767.451743049559;4788.569028787426;4802.951970480285;4913.8771530711665;4995.325631039799;5050.898982020339;5053.6967781932835;5123.538881500683;5577.609567330289;5613.971930140323;5623.690697011662;5637.069883469223;5665.036943719578;5629.915551266734;5631.324241091095;5641.492265696066;5648.661080335193;5651.547876169897;5198.246254293106;5250.97374513125;5273.9736301318635;5275.340582427197;5290.497402746733;5768;5828.766849326064;5831.475167234969;5842.123681447817;5870.3249126350165;5544.306961629796;5566.443355664401;5569.331680198321;5573.164025396142;5575.888482230333;5409.513143817076;5479.424660410679;5541.5289700375115;5577.05190117681;5640.294963129609;5555.1667249912025;5575.99632066232;5578.442155784389;5596.636218645775;5624.156376543551;5540.113581826889;5545.750441230154;5558.666480011212;5599.720013999284;5616.241807356037;4244.0663054128045;4350.1734670412525;4364.607185353333;4405.471343438808;4416.33754936762;3852.768833869921;3910.687145028391;3923.391874259494;3924.3132451820816;3956.228535435562;5261.868453288622;5303.628745987744;5312.601554883399;5313.149896016619;5313.229581710708;5460.672359658433;5573;5648;5695.7152142392715;5753.597248192586;5347;5354.651947623392;5362.1420572708175;5378.381486129145;5389;4876;4884.7069175849565;4889.413270407503;4893.119238537026;4934.654574179773;5629.774809007594;5665.745041473061;5714.485696287354;5716.714164291852;5717.628354156966;5480.506754392124;5501.862453438696;5504.834854954358;5661.122526008476;5755.884882302415;5829.125631155361;5869.6771677558145;5896.70516474166;5906.734196961061;5911.261092363455;5564.554835613222;5565.916511252253;5594.468525490072;5600.523955463831;5619.550435965195;5493.505584497255;5521.4478552144465;5583.106702927512;5642.633228840113;5692.886142277049;5498.120300751861;5533.335999680065;5557.72211389437;5562.471565201299;5568.805091821767;5472.890542189213;5473.17902314656;5503.972480137573;5514.420985796433;5531.806386776604;5288.233206185158;5317.867053323698;5340.465953404629;5351.411344752152;5433.402325744244;5518.034343989705;5530.585206109638;5548.223248745098;5575.247341608993;5575.832725018256;5398.946010539844;5435.809746658848;5450.972745136249;5480.972595136999;5503.834884953458 07:29:35 INFO - PROCESS | 25382 | |1;ext.html;506.38221369928675;525.1702310349648;547.1000204663329;563.228377123341;568.3833041150351;27366.315842103933;35342.64657353426;35441.11397215068;35664.286714265734;35818.10454738633;38155;38688.41967370492;38693.419598706045;38743.418848717294;38751.806240968755;8375.37184711146;8387.329013678891;8527.573621318941;8539.146085391441;8576.957115214447;8371.95814020929;8462.36532260083;8465.74602761915;8482.618282177316;8515.403921725481;8470.44942078766;8488;8498.490090594552;8515.829683406328;8529.786755331104;8371.204735550144;8452.197041281068;8484.872726909101;8662.350323725683;8702.347323950666;8541.914580854174;8664.133586641348;8735.868961965512;8760.649574017032;8803.603837827313;38193;38661.806690966645;38673.613263867286;38877.61122388768;38985.610143898484;3152.5586417901513;3198.9200269993203;3297.8021318720953;3778.924421511582;3872.67082298005;29305.706942930512;29526;29876;30255;30717;3930.4693866327966;3937.684985201177;4019.417184508259;4086.427900093989;4121.5878412158545;212576;213966;214856;263184;271442.6427867868;58229.70885145632;58635.70682146562;59095.70452147798;59248.7037564818;59382;54614;54746.72626636921;54930;55140.72429637906;55154;13502.122362046435;13562.59312220635;13628.250446225553;13646.385912633956;13679.589612311647;10267.332623379456;10298.3820970742;10299.17606591471;10300.587976480856;10306.845397319046;20482.38552843417;20566.69149962752;20667.17331306761;20751.8962405187;20815.271465498634;7883.684652613946;8116.553589552514;8156.796080098045;8237.46456480339;8272.503649781032;919.4529255093208;952.3761935931975;977.8826540815147;981.9361741486781;1029.5984566019258;28580.285492862844;28804.29897020449;28901.710982890323;29365.706342936726;29476.705232947395;1056.5404049238605;1161.488944864274;1174.9588764393377;1204.8192771084407;1222.93273869938;14930.925345373204;15003.474878379204;15315.15766632846;16039.67920641604;16398.754018689728;297683;299512;299879;300440;301437;54618.72690636521;55307.44692553103;55363.446365536634;55382.446175538535;55555.44444555583;1341.3494455189225;1344.0860215053858;1347.3600039981127;1348.2382453913508;1463.4073200353873;29216.7078329214;30140.69859301379;30421;30846.383072338875;30909.690903090683;49137.508624913295;50004.499954999985;50286.245706313704;50316.74841625769;50461;292759;293835;294704;296575;296989;42313.153736925706;42497.78751106225;42581.57418425776;43033.56966430296;43649.34525982176;37976;37987.43018854664;38659.6134038656;38978.2204355917;39119.60880391159;32731.181720456225;32973.17567060843;35377.82311088428;36490.452643210905;36547.81726091352;35574.46638300376;36552.26895462129;36700.63299367079;36866.8156659215;37049.25901482009;35184.47223291704;35393.82303088468;35624.287514250085;37443.25113497769;38208.61791382162;28764;30273.24316892095;31276;32456.51315230226;33144;24447.87776061108;24713.876430617733;24791.62812557777;25207.11775087863;25329.49341013206 07:29:35 INFO - PROCESS | 25382 | |2;jquery.html;358.8941262327613;361.19453618430896;361.87153560486024;363.23176481741115;370.14311868025504;16033.759493607591;16802.579935501588;16821.74767378489;17191.054492002935;17576.912115439405;10522.842157367626;10884.945575272131;14935.551933442013;15239.542813715607;15266.770998435033;4737.90524189516;4886.144924638192;5410.404855465896;5413.485718856722;5414.675119492823;4286.863981045026;5345.33183352081;5356.517913387795;5391.029614669358;5401.297831281928;5266.078436273656;5312.495312945264;5362.705051222181;5440.347158341005;5452.700101494416;4747.572718455355;4914.385701787277;5026.623003274751;5408.945910540903;5418.756155972991;4693.88265293367;4744.169770290186;4745.59662428694;4746.952530474686;4749.501302363271;14696.853031469762;19353.225870965143;19919.50201244966;19927;20041.1983520659;2188.8248940084754;2207.150247154841;2369.9763002369928;2566.4995325911455;2819.9013034543896;8752.912470875273;9203.309751768644;9325.673601423918;9408.388454750488;9727.854082188773;1873.9063046847739;1883.7456943312613;1936.5352315444334;1942.6114777044647;1965.1549833571557;58337.416625833626;59298.70350648262;60710;61178.08232876511;61263.69368153175;10192.694219173436;10200.591976320864;10325.173986081096;10351.223658225663;10434.321769084985;11696.824547631792;11852.348120853263;12298.446569904376;13455.125416847874;13567.932160339134;5557.360903496069;5724.914126288109;6228.781992630236;7048.929510704827;7055.858882822417;6741.831454213586;6752.291009444036;6753.054572359873;6763.458923286125;6805.693743781443;4178.811953462041;4349.369341445473;4391.231534481453;4397.548808893058;4489.461264648197;1699.3431404380876;1756.938507152269;1762.691528982423;1846.3168627607872;1864.822841830024;870.5647176411794;881.7090360181124;889.6174644902754;946.4841661294611;958.6165533786541;16090.195490225442;16186.676266474604;16284.26720797567;16532.09073500945;16623.750643740354;868.561376504861;891.2780647675404;909.417972497602;928.7770934975557;951.7620594851287;8677.956610216908;9110.088991100836;9347.158755712018;9953.900460995297;10079.647212347532;366804;378733;379456;526991;530936;61286;64077.67961160164;64312;64636.353636463034;72347.63826180836;1111.9833202501968;1133.4955944604737;1143.0626885953604;1143.3140115930541;1145.1811954452605;9930.106290433896;10130.544125514516;10157.136643385395;14908.62728431798;15114.09315441077;31976.360472789947;32100.357992839545;32613.510797337585;34126;35927.10182245465;46718.299225510964;47368.052638947716;47432.2885156716;47805.282920756916;48696.513034870615;9698.9030109698;10204.642837500653;10437.373757574569;10614.89385106139;10652.254342195973;11806;11981;12067.155299128977;12312.50749970027;12420.441080151595;10489.580416783243;10558.472076395996;10726.141908647445;11064.446777660924;11069.833952490559;10320.329178603668;10635.308704934154;10932.726681833017;11010.614628487965;11237.269577477438;7036.437085033082;7089.468289878177;7104.360607545345;7495.775126746206;10913.836292455779;9316.254699624149;9697.17472525829;9724.611015559582;9885;9890.85163722559;10253.538590763583;10354.275200735876;10389.428581428094;10424.322419042737;10543.15654747603 07:29:35 INFO - PROCESS | 25382 | |3;mootools.html;1475.6827282134343;1481.6147801571594;1637.2632315458047;1762.1101393714318;1787.6424715056992;7561.470697051209;7703.46075774696;7724.188960159173;7895.64469598868;7924.683012679493;7821.648025838851;7834.529928204312;7841.059072911258;7886.566238856861;7910.841783164333;2328.860268383898;2347.295811256625;2359.4809141988735;2361.1499860050367;2365.1012615206196;2291.0835665733757;2293.7935585797277;2312.144506532585;2329.406001469623;2332.591796435617;2249.3814201094665;2286.131270117353;2289.67944487771;2311.4452531392512;2322.1640209524644;2165.372042107787;2267.161150374364;2269.3986093685185;2300.6088964875926;2301.562703086425;2232.8771917544527;2234.5084081502046;2243.932682019542;2248.123231939545;2249.280230326296;7940.444168908179;7948;7985.560794156319;7993.120756716757;8029.799255018613;4675.275332323496;4782.880427989293;4786.569208771228;4793.688410253358;4828.879278018043;3048.3141293209073;3106.2855543225187;3211.8394080295893;3231.0952933178746;3249.788763730374;1029.12524354299;1048.774513479598;1059.4596755654595;1063.4682658670665;1949.8788196786904;10522.31604945676;10552;10562.947185264102;10567.524461399178;10601.893981060168;4144.129732756095;4197.034682023091;4200.6429453496185;4300.935485967713;4309.84915527955;8517.488950662857;8538.316934645214;8627.439216451035;8641.654333826702;8670;4624.884377890579;4649.279361698942;4668.276417155346;4673.345731597579;4678.836240731626;4274.700770946066;4277.508086570084;4320.827166913351;4320.913581728348;4342.131573685276;3307.4046671598862;3346.113279980807;3357.764956453074;3412.7952322860706;3428.7428442866885;938.0900526489295;1003.1874181912674;1029.8455231715302;1041.416806588313;1044.4307852220406;910.8724778531011;1068.7969285835666;1092.748667806409;1169.6783384569312;1301.9218846869219;7127.10911136108;7155.284471552803;7212.350888420067;7237.493375463667;7268.418526517866;616.140484024783;618.8576627375729;630.1209812311799;635.8569321902535;768.727101878825;5367.516923476827;5534.418886016911;5679.062954612443;5692.174634678031;5719.113537401709;9394.765130871647;9659.034096590285;9667.226621870233;9670.90329096714;9733.561989710339;9424.246060315158;9513;9514.619415223451;9582.760430989281;9594.712158635251;7356.742514011984;7470.103587569418;7485;7505.774826755206;7540.17058123595;7125.144074604507;7133.215346312006;7175.647013134367;7229.277072292729;7270.309320614533;8432.45189062709;8435.32517398619;8538.871916921375;8622.655093796178;8642.697505587274;8736.78158046054;8817.647294108165;8836.204741573289;8863.202311791712;8869.334799889904;6655.500837437308;6709.161354830646;6722.596644201363;6737.62943038118;6779.593224406552;7240.601766902871;7251.383632391306;7356;7549.584772837547;7618.390528757797;6899.310068993061;6963.7214511421;7026.8945965809535;7037.648117593997;7109.786706398816;6258;6692.096566963398;6881.380675739208;6979.511434199558;7018.473614479037;6724.361185687352;6772.187337519529;6787.89818152738;6795.38841504267;6835.965820170867;6346.619202847844;6348.714307856065;6389.584676995981;6418.55070145104;6436.871262574816;6487.967560162169;6516.055172000129;6522.249941256816;6553.311902250195;6581.638009909501 07:29:35 INFO - PROCESS | 25382 | |4;prototype.html;327.322442543934;329.99670003299957;330.077433573163;330.7420212234458;341.344618332801;6265.373462653738;6283.685815709214;6314.8737025259525;6330.082138089974;6464.644444555547;6259.37406259375;6310.305866354709;6316.147320111783;6328.303886572473;6366.108744775735;4749.76251187441;4791.305260737191;4797.352357431737;4804.159272127364;4805;4808.759562021903;4809.975950120262;4812.470628230892;4812.639052071091;4828.927566086511;4636.605888499482;4710.175719249135;4711.6466265030085;4714.622830173595;4718.764061796914;4709.434867815867;4710.882227944312;4713.363695901044;4735.479097299294;4740.5733483986605;4049.979750101231;4067.7966101694797;4068.5524592294823;4070.0842310480202;4088.325426304656;5934.228550288478;5965.4929331006915;5979.940200597982;5988.730507127146;6004.0693692477735;5380.408155102936;5473.17902314652;5474.72626368684;5486.972565137189;5500.092484740013;6617.139771829679;6618.238902526223;6636.966815165942;6657.733690652368;6663.300353462865;4454.866354009385;4456.041950980522;4479.081788233404;4486.685931984763;4489.326601009842;6768.69540870662;6923;6952.895706564405;6993.405560527362;7003.15962084548;4576.88557786058;4585.312203169551;4590.540945905383;4593.6095431888;4605.677602567788;4625.976870115628;4636.536346365337;4644.326572646947;4647.767611619473;4648.790804413809;5432.2123292123215;5441.782328706887;5446.509814116748;5456.590755693339;5460.918086228709;6476.125723027331;6692.163479565054;6720.630365329954;6752.5273230874345;6757.729690812411;1611.025329675553;1634.207409406437;1654.1729135432283;1659.7510373443838;1660.9750853737203;1100.5212732461405;1111.183280288987;1112.6773235761539;1114.0641860836936;1122.93262404256;6252.843678908063;6267.2792628847355;6290.276618188876;6294.716737746812;6341.587796793194;6746.527743057939;6774.051632771318;6787.321267873272;6796.286389929085;6812.420944219698;6132.601380910227;6244.500439964882;6247.75008999644;6306.747730090745;6328.7468501260355;3650.470681751131;3672.5776535698737;3683.631636836295;3703.185299234164;3712.7957962311793;7124.786256412316;7126.144862616519;7130.679119439637;7143.178534468499;7182.174049984214;6847.726090956406;7006.264342244093;7012.439004879598;7015.929840701528;7033.226345102034;7144;7144.214136444987;7146.714131434788;7152.892706609405;7161.641917904084;6783.728650853911;6791;6822.454203663596;6827;6841.452683785185;6633.668316584055;6680.63256520896;6726.192856857013;6743.35938085881;6748.7300507979135;7023.33278338557;7054.08296921397;7113.57318560888;7117.252688467636;7152.642367881481;4591.747453890068;4611.93082103762;4613.19269127908;4615.79228934692;4616.746078965555;6758.256591774999;6823.761168359084;6853.314668533107;6863.656817159222;6982.406495447741;6794.422474089758;6800.217974932946;6826.249112597709;6831.6242606657115;6868.381845633917;6820.488463365168;6830.419414349637;6836.111305530449;6839.692213850488;6840.384365407137;6501.1548498694865;6583.078369028436;6614.768483103068;6631.767888123893;6655.633940133339;6748.257691654012;6753.729850805913;6778.051072849904;6835.4189893859575;6845.110135682528;6575.638339891352;6635.402813746786;6644.235912870082;6655.301193374626;6658.5671931324305 07:29:35 INFO - PROCESS | 25382 | |5;yui.html;792.3977776889562;806.8789681547767;808.123186342818;825.257268458387;855.2815634866711;12344.13591048627;12668.113232073736;12701.872981270197;12723.872761272385;12743.171693839893;11407.54369825208;11503.367314797704;11571.247868888537;11580.189386742932;11583.710407239823;815.4495715392102;822.7901885019312;829.7635173975418;830.4104086098877;830.7466222802043;810.068421315486;815.4984684419098;816.2368185746317;817.1215942861418;820.7209548753423;855.2687452228348;855.4012191465968;855.4396870050095;858.4891989266408;861.2507118806647;849.4223927729141;850.4897061762955;851.3019324154196;855.8930133733284;856.8372009318209;621.1335187413578;626.9811905642838;627.6861569215392;628.3433811666819;630.3759278314482;12528.74942501154;12683.112182147253;12685.17546359493;12724.045696572794;12741.936290318488;10875.184361172944;10997.450127493594;11021.779564408747;11181;11454.48454819535;9695.854562181574;9764.90235097647;9774.5601447935;9785.902140978571;9876.308658393915;3474.2530355973336;3549.680528752425;3588.2464682416726;3678.337899178147;3743.8315275812383;41256.79371603153;41699;45565.31652025222;46438.30342544865;48158.27762583564;9739.464329461805;9876.753081172885;9936.80126397468;10183.236257280734;10345.741356465998;15182.620434489227;15342.539723808304;15357.155356455502;15375;15376.308066137051;7210.567365957954;7383.852322953511;7558.433117516208;7585.393168546503;7868.055833300041;3845.576986531479;3906.335922893058;3949.5458022327225;4002.5597184309704;4067.9389809152885;3075.2926826829953;3111.3932783107075;3114.641816191167;3118.672539383332;3127.9530807037913;572.5963195946847;572.6707143392566;581.970901454934;583.151514546334;583.8657108864985;476.2879495154697;507.778792005228;603.5081408651935;622.5082185073741;664.869721473497;7926.8810967835525;7933.722319718782;8020.238077382639;8199.344052475788;8346.081930987586;572.9026065568863;613.4049971527611;640.4140211706236;644.8742495213482;654.456800855289;3763.8306276217636;3863.96136038636;4238.703290769617;4240.84836854119;4292.935605965913;50533.494665053615;52451.47548524542;52597;52627;52894;46760.76619616948;46840.53159468362;47329.29006064912;48100;48210.276845847344;49481;49573.504264956886;50253;50460;51029.74485127625;8441.240288374076;8691;8738.169873861973;8793.648254069765;8875.778105547413;34200.14499637529;34320.82839585786;34677.65322346845;35177.64822351744;35257.82371088128;39175.608243917195;39842.60157398389;42750.144997100506;43487.78256108699;43968.12063758771;10080.798384032132;10210.336328138646;10225.539850706587;10228.07947284748;10280;11642.24325418879;11859.229150105215;11876.584319548774;12472.376381181086;12636;10290.228232882415;10410.47947602632;10562.049415552638;10562.207834412297;11049.558017679203;10421.426821524889;10460.320079195133;10539.26225164231;10586.629467968583;10818.783624327627;9775.560099795668;9923.1069203772;10042.674394865224;10154.543045563116;10285.640002599874;8902.910970890209;8933.28533717314;9002.639894404412;9130.041345658876;9165.083491650781;8570.4000719949;8734.213920747163;8789.384743067923;9465.66870159541;9804.558794854105 07:29:35 INFO - PROCESS | 25382 | __end_tp_report 07:29:35 INFO - PROCESS | 25382 | __start_cc_report 07:29:35 INFO - PROCESS | 25382 | _x_x_mozilla_cycle_collect,312 07:29:35 INFO - PROCESS | 25382 | __end_cc_report 07:29:35 INFO - PROCESS | 25382 | __startTimestamp1453994975269__endTimestamp 07:29:35 INFO - PROCESS | 25382 | 07:29:35 INFO - PROCESS | 25382 | ------- Summary: start ------- 07:29:35 INFO - PROCESS | 25382 | Number of tests: 6 07:29:35 INFO - PROCESS | 25382 | 07:29:35 INFO - PROCESS | 25382 | [#0] dojo.html Cycles:165 Average:5225.95 Median:5435.81 stddev:566.17 (10.4%) stddev-sans-first:543.50 07:29:35 INFO - PROCESS | 25382 | Values: 3129.5 3177.5 3183.9 3187.8 3221.6 5103.6 5212.2 5223.6 5243.7 5281.4 5079.5 5189.7 5275.4 5309.5 5321.8 4739.5 4813.8 4830.7 4834.9 4922.6 4825.0 4833.3 4843.1 4904.3 4960.6 4674.5 4737.5 4756.0 4831.6 4862.2 4769.6 4770.9 4771.0 4786.6 4803.3 4697.6 4758.5 4767.5 4788.6 4803.0 4913.9 4995.3 5050.9 5053.7 5123.5 5577.6 5614.0 5623.7 5637.1 5665.0 5629.9 5631.3 5641.5 5648.7 5651.5 5198.2 5251.0 5274.0 5275.3 5290.5 5768.0 5828.8 5831.5 5842.1 5870.3 5544.3 5566.4 5569.3 5573.2 5575.9 5409.5 5479.4 5541.5 5577.1 5640.3 5555.2 5576.0 5578.4 5596.6 5624.2 5540.1 5545.8 5558.7 5599.7 5616.2 4244.1 4350.2 4364.6 4405.5 4416.3 3852.8 3910.7 3923.4 3924.3 3956.2 5261.9 5303.6 5312.6 5313.1 5313.2 5460.7 5573.0 5648.0 5695.7 5753.6 5347.0 5354.7 5362.1 5378.4 5389.0 4876.0 4884.7 4889.4 4893.1 4934.7 5629.8 5665.7 5714.5 5716.7 5717.6 5480.5 5501.9 5504.8 5661.1 5755.9 5829.1 5869.7 5896.7 5906.7 5911.3 5564.6 5565.9 5594.5 5600.5 5619.6 5493.5 5521.4 5583.1 5642.6 5692.9 5498.1 5533.3 5557.7 5562.5 5568.8 5472.9 5473.2 5504.0 5514.4 5531.8 5288.2 5317.9 5340.5 5351.4 5433.4 5518.0 5530.6 5548.2 5575.2 5575.8 5398.9 5435.8 5451.0 5481.0 5503.8 07:29:35 INFO - PROCESS | 25382 | 07:29:35 INFO - PROCESS | 25382 | [#1] ext.html Cycles:180 Average:44921.75 Median:36958.04 stddev:72720.34 (196.8%) stddev-sans-first:72847.88 07:29:35 INFO - PROCESS | 25382 | Values: 506.4 525.2 547.1 563.2 568.4 27366.3 35342.6 35441.1 35664.3 35818.1 38155.0 38688.4 38693.4 38743.4 38751.8 8375.4 8387.3 8527.6 8539.1 8577.0 8372.0 8462.4 8465.7 8482.6 8515.4 8470.4 8488.0 8498.5 8515.8 8529.8 8371.2 8452.2 8484.9 8662.4 8702.3 8541.9 8664.1 8735.9 8760.6 8803.6 38193.0 38661.8 38673.6 38877.6 38985.6 3152.6 3198.9 3297.8 3778.9 3872.7 29305.7 29526.0 29876.0 30255.0 30717.0 3930.5 3937.7 4019.4 4086.4 4121.6 212576.0 213966.0 214856.0 263184.0 271442.6 58229.7 58635.7 59095.7 59248.7 59382.0 54614.0 54746.7 54930.0 55140.7 55154.0 13502.1 13562.6 13628.3 13646.4 13679.6 10267.3 10298.4 10299.2 10300.6 10306.8 20482.4 20566.7 20667.2 20751.9 20815.3 7883.7 8116.6 8156.8 8237.5 8272.5 919.5 952.4 977.9 981.9 1029.6 28580.3 28804.3 28901.7 29365.7 29476.7 1056.5 1161.5 1175.0 1204.8 1222.9 14930.9 15003.5 15315.2 16039.7 16398.8 297683.0 299512.0 299879.0 300440.0 301437.0 54618.7 55307.4 55363.4 55382.4 55555.4 1341.3 1344.1 1347.4 1348.2 1463.4 29216.7 30140.7 30421.0 30846.4 30909.7 49137.5 50004.5 50286.2 50316.7 50461.0 292759.0 293835.0 294704.0 296575.0 296989.0 42313.2 42497.8 42581.6 43033.6 43649.3 37976.0 37987.4 38659.6 38978.2 39119.6 32731.2 32973.2 35377.8 36490.5 36547.8 35574.5 36552.3 36700.6 36866.8 37049.3 35184.5 35393.8 35624.3 37443.3 38208.6 28764.0 30273.2 31276.0 32456.5 33144.0 24447.9 24713.9 24791.6 25207.1 25329.5 07:29:35 INFO - PROCESS | 25382 | 07:29:35 INFO - PROCESS | 25382 | [#2] jquery.html Cycles:180 Average:24626.72 Median:189551.57 stddev:72554.74 (38.3%) stddev-sans-first:72735.39 07:29:35 INFO - PROCESS | 25382 | Values: 358.9 361.2 361.9 363.2 370.1 16033.8 16802.6 16821.7 17191.1 17576.9 10522.8 10884.9 14935.6 15239.5 15266.8 4737.9 4886.1 5410.4 5413.5 5414.7 4286.9 5345.3 5356.5 5391.0 5401.3 5266.1 5312.5 5362.7 5440.3 5452.7 4747.6 4914.4 5026.6 5408.9 5418.8 4693.9 4744.2 4745.6 4747.0 4749.5 14696.9 19353.2 19919.5 19927.0 20041.2 2188.8 2207.2 2370.0 2566.5 2819.9 8752.9 9203.3 9325.7 9408.4 9727.9 1873.9 1883.7 1936.5 1942.6 1965.2 58337.4 59298.7 60710.0 61178.1 61263.7 10192.7 10200.6 10325.2 10351.2 10434.3 11696.8 11852.3 12298.4 13455.1 13567.9 5557.4 5724.9 6228.8 7048.9 7055.9 6741.8 6752.3 6753.1 6763.5 6805.7 4178.8 4349.4 4391.2 4397.5 4489.5 1699.3 1756.9 1762.7 1846.3 1864.8 870.6 881.7 889.6 946.5 958.6 16090.2 16186.7 16284.3 16532.1 16623.8 868.6 891.3 909.4 928.8 951.8 8678.0 9110.1 9347.2 9953.9 10079.6 366804.0 378733.0 379456.0 526991.0 530936.0 61286.0 64077.7 64312.0 64636.4 72347.6 1112.0 1133.5 1143.1 1143.3 1145.2 9930.1 10130.5 10157.1 14908.6 15114.1 31976.4 32100.4 32613.5 34126.0 35927.1 46718.3 47368.1 47432.3 47805.3 48696.5 9698.9 10204.6 10437.4 10614.9 10652.3 11806.0 11981.0 12067.2 12312.5 12420.4 10489.6 10558.5 10726.1 11064.4 11069.8 10320.3 10635.3 10932.7 11010.6 11237.3 7036.4 7089.5 7104.4 7495.8 10913.8 9316.3 9697.2 9724.6 9885.0 9890.9 10253.5 10354.3 10389.4 10424.3 10543.2 07:29:35 INFO - PROCESS | 25382 | 07:29:35 INFO - PROCESS | 25382 | [#3] mootools.html Cycles:180 Average:5442.50 Median:6404.07 stddev:2844.95 (44.4%) stddev-sans-first:2837.30 07:29:35 INFO - PROCESS | 25382 | Values: 1475.7 1481.6 1637.3 1762.1 1787.6 7561.5 7703.5 7724.2 7895.6 7924.7 7821.6 7834.5 7841.1 7886.6 7910.8 2328.9 2347.3 2359.5 2361.1 2365.1 2291.1 2293.8 2312.1 2329.4 2332.6 2249.4 2286.1 2289.7 2311.4 2322.2 2165.4 2267.2 2269.4 2300.6 2301.6 2232.9 2234.5 2243.9 2248.1 2249.3 7940.4 7948.0 7985.6 7993.1 8029.8 4675.3 4782.9 4786.6 4793.7 4828.9 3048.3 3106.3 3211.8 3231.1 3249.8 1029.1 1048.8 1059.5 1063.5 1949.9 10522.3 10552.0 10562.9 10567.5 10601.9 4144.1 4197.0 4200.6 4300.9 4309.8 8517.5 8538.3 8627.4 8641.7 8670.0 4624.9 4649.3 4668.3 4673.3 4678.8 4274.7 4277.5 4320.8 4320.9 4342.1 3307.4 3346.1 3357.8 3412.8 3428.7 938.1 1003.2 1029.8 1041.4 1044.4 910.9 1068.8 1092.7 1169.7 1301.9 7127.1 7155.3 7212.4 7237.5 7268.4 616.1 618.9 630.1 635.9 768.7 5367.5 5534.4 5679.1 5692.2 5719.1 9394.8 9659.0 9667.2 9670.9 9733.6 9424.2 9513.0 9514.6 9582.8 9594.7 7356.7 7470.1 7485.0 7505.8 7540.2 7125.1 7133.2 7175.6 7229.3 7270.3 8432.5 8435.3 8538.9 8622.7 8642.7 8736.8 8817.6 8836.2 8863.2 8869.3 6655.5 6709.2 6722.6 6737.6 6779.6 7240.6 7251.4 7356.0 7549.6 7618.4 6899.3 6963.7 7026.9 7037.6 7109.8 6258.0 6692.1 6881.4 6979.5 7018.5 6724.4 6772.2 6787.9 6795.4 6836.0 6346.6 6348.7 6389.6 6418.6 6436.9 6488.0 6516.1 6522.2 6553.3 6581.6 07:29:35 INFO - PROCESS | 25382 | 07:29:35 INFO - PROCESS | 25382 | [#4] prototype.html Cycles:180 Average:5547.44 Median:6308.53 stddev:1702.75 (27.0%) stddev-sans-first:1661.84 07:29:35 INFO - PROCESS | 25382 | Values: 327.3 330.0 330.1 330.7 341.3 6265.4 6283.7 6314.9 6330.1 6464.6 6259.4 6310.3 6316.1 6328.3 6366.1 4749.8 4791.3 4797.4 4804.2 4805.0 4808.8 4810.0 4812.5 4812.6 4828.9 4636.6 4710.2 4711.6 4714.6 4718.8 4709.4 4710.9 4713.4 4735.5 4740.6 4050.0 4067.8 4068.6 4070.1 4088.3 5934.2 5965.5 5979.9 5988.7 6004.1 5380.4 5473.2 5474.7 5487.0 5500.1 6617.1 6618.2 6637.0 6657.7 6663.3 4454.9 4456.0 4479.1 4486.7 4489.3 6768.7 6923.0 6952.9 6993.4 7003.2 4576.9 4585.3 4590.5 4593.6 4605.7 4626.0 4636.5 4644.3 4647.8 4648.8 5432.2 5441.8 5446.5 5456.6 5460.9 6476.1 6692.2 6720.6 6752.5 6757.7 1611.0 1634.2 1654.2 1659.8 1661.0 1100.5 1111.2 1112.7 1114.1 1122.9 6252.8 6267.3 6290.3 6294.7 6341.6 6746.5 6774.1 6787.3 6796.3 6812.4 6132.6 6244.5 6247.8 6306.7 6328.7 3650.5 3672.6 3683.6 3703.2 3712.8 7124.8 7126.1 7130.7 7143.2 7182.2 6847.7 7006.3 7012.4 7015.9 7033.2 7144.0 7144.2 7146.7 7152.9 7161.6 6783.7 6791.0 6822.5 6827.0 6841.5 6633.7 6680.6 6726.2 6743.4 6748.7 7023.3 7054.1 7113.6 7117.3 7152.6 4591.7 4611.9 4613.2 4615.8 4616.7 6758.3 6823.8 6853.3 6863.7 6982.4 6794.4 6800.2 6826.2 6831.6 6868.4 6820.5 6830.4 6836.1 6839.7 6840.4 6501.2 6583.1 6614.8 6631.8 6655.6 6748.3 6753.7 6778.1 6835.4 6845.1 6575.6 6635.4 6644.2 6655.3 6658.6 07:29:35 INFO - PROCESS | 25382 | 07:29:35 INFO - PROCESS | 25382 | [#5] yui.html Cycles:180 Average:13091.92 Median:48845.64 stddev:15216.56 (31.2%) stddev-sans-first:15231.21 07:29:35 INFO - PROCESS | 25382 | Values: 792.4 806.9 808.1 825.3 855.3 12344.1 12668.1 12701.9 12723.9 12743.2 11407.5 11503.4 11571.2 11580.2 11583.7 815.4 822.8 829.8 830.4 830.7 810.1 815.5 816.2 817.1 820.7 855.3 855.4 855.4 858.5 861.3 849.4 850.5 851.3 855.9 856.8 621.1 627.0 627.7 628.3 630.4 12528.7 12683.1 12685.2 12724.0 12741.9 10875.2 10997.5 11021.8 11181.0 11454.5 9695.9 9764.9 9774.6 9785.9 9876.3 3474.3 3549.7 3588.2 3678.3 3743.8 41256.8 41699.0 45565.3 46438.3 48158.3 9739.5 9876.8 9936.8 10183.2 10345.7 15182.6 15342.5 15357.2 15375.0 15376.3 7210.6 7383.9 7558.4 7585.4 7868.1 3845.6 3906.3 3949.5 4002.6 4067.9 3075.3 3111.4 3114.6 3118.7 3128.0 572.6 572.7 582.0 583.2 583.9 476.3 507.8 603.5 622.5 664.9 7926.9 7933.7 8020.2 8199.3 8346.1 572.9 613.4 640.4 644.9 654.5 3763.8 3864.0 4238.7 4240.8 4292.9 50533.5 52451.5 52597.0 52627.0 52894.0 46760.8 46840.5 47329.3 48100.0 48210.3 49481.0 49573.5 50253.0 50460.0 51029.7 8441.2 8691.0 8738.2 8793.6 8875.8 34200.1 34320.8 34677.7 35177.6 35257.8 39175.6 39842.6 42750.1 43487.8 43968.1 10080.8 10210.3 10225.5 10228.1 10280.0 11642.2 11859.2 11876.6 12472.4 12636.0 10290.2 10410.5 10562.0 10562.2 11049.6 10421.4 10460.3 10539.3 10586.6 10818.8 9775.6 9923.1 10042.7 10154.5 10285.6 8902.9 8933.3 9002.6 9130.0 9165.1 8570.4 8734.2 8789.4 9465.7 9804.6 07:29:35 INFO - PROCESS | 25382 | -------- Summary: end -------- 07:29:35 INFO - PROCESS | 25382 | 07:29:35 INFO - TEST-INFO | 25382: exit 0 07:29:35 INFO - TEST-OK | dromaeo_css | took 1110153ms 07:29:35 INFO - TEST-START | kraken 07:29:35 INFO - operating with platform_type : linux_ 07:29:35 INFO - Initialising browser for kraken test... 07:29:35 INFO - TEST-INFO | started process 25619 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSxfMJr/profile http://localhost:34614/getInfo.html) 07:29:39 INFO - PROCESS | 25619 | 07:29:39 INFO - PROCESS | 25619 | (process:25692): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:29:40 INFO - PROCESS | 25619 | __metrics Screen width/height:1600/1200 07:29:40 INFO - PROCESS | 25619 | colorDepth:24 07:29:40 INFO - PROCESS | 25619 | Browser inner width/height: 1024/697 07:29:40 INFO - PROCESS | 25619 | __metrics 07:29:40 INFO - PROCESS | 25619 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:29:41 INFO - TEST-INFO | 25619: exit 0 07:29:41 INFO - Browser initialized. 07:29:41 INFO - Running cycle 1/1 for kraken test... 07:29:41 INFO - TEST-INFO | started process 25741 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSxfMJr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:29:42 INFO - PROCESS | 25741 | 07:29:42 INFO - PROCESS | 25741 | (process:25798): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:29:53 INFO - PROCESS | 25741 | RSS: Main: 151433216 07:29:53 INFO - PROCESS | 25741 | 07:29:55 INFO - PROCESS | 25741 | Cycle 1(1): loaded http://localhost:34614/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34614/tests/kraken/driver.html?testName=audio-beat-detection) 07:29:56 INFO - PROCESS | 25741 | RSS: Main: 155947008 07:29:56 INFO - PROCESS | 25741 | 07:29:59 INFO - PROCESS | 25741 | Cycle 1(1): loaded http://localhost:34614/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34614/tests/kraken/driver.html?testName=audio-dft) 07:29:59 INFO - PROCESS | 25741 | RSS: Main: 159449088 07:29:59 INFO - PROCESS | 25741 | 07:30:02 INFO - PROCESS | 25741 | Cycle 1(1): loaded http://localhost:34614/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34614/tests/kraken/driver.html?testName=audio-fft) 07:30:03 INFO - PROCESS | 25741 | RSS: Main: 153677824 07:30:03 INFO - PROCESS | 25741 | 07:30:05 INFO - PROCESS | 25741 | Cycle 1(1): loaded http://localhost:34614/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34614/tests/kraken/driver.html?testName=audio-oscillator) 07:30:06 INFO - PROCESS | 25741 | RSS: Main: 153333760 07:30:06 INFO - PROCESS | 25741 | 07:30:08 INFO - PROCESS | 25741 | Cycle 1(1): loaded http://localhost:34614/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34614/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:30:08 INFO - PROCESS | 25741 | RSS: Main: 154644480 07:30:08 INFO - PROCESS | 25741 | 07:30:11 INFO - PROCESS | 25741 | Cycle 1(1): loaded http://localhost:34614/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34614/tests/kraken/driver.html?testName=imaging-darkroom) 07:30:12 INFO - PROCESS | 25741 | RSS: Main: 154005504 07:30:12 INFO - PROCESS | 25741 | 07:30:15 INFO - PROCESS | 25741 | Cycle 1(1): loaded http://localhost:34614/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34614/tests/kraken/driver.html?testName=imaging-desaturate) 07:30:16 INFO - PROCESS | 25741 | RSS: Main: 154062848 07:30:16 INFO - PROCESS | 25741 | 07:30:19 INFO - PROCESS | 25741 | Cycle 1(1): loaded http://localhost:34614/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34614/tests/kraken/driver.html?testName=json-parse-financial) 07:30:19 INFO - PROCESS | 25741 | RSS: Main: 154603520 07:30:19 INFO - PROCESS | 25741 | 07:30:21 INFO - PROCESS | 25741 | Cycle 1(1): loaded http://localhost:34614/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34614/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:30:22 INFO - PROCESS | 25741 | RSS: Main: 155152384 07:30:22 INFO - PROCESS | 25741 | 07:30:23 INFO - PROCESS | 25741 | Cycle 1(1): loaded http://localhost:34614/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34614/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:30:24 INFO - PROCESS | 25741 | RSS: Main: 155066368 07:30:24 INFO - PROCESS | 25741 | 07:30:26 INFO - PROCESS | 25741 | Cycle 1(1): loaded http://localhost:34614/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34614/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:30:27 INFO - PROCESS | 25741 | RSS: Main: 155291648 07:30:27 INFO - PROCESS | 25741 | 07:30:29 INFO - PROCESS | 25741 | Cycle 1(1): loaded http://localhost:34614/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34614/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:30:30 INFO - PROCESS | 25741 | RSS: Main: 154492928 07:30:30 INFO - PROCESS | 25741 | 07:30:32 INFO - PROCESS | 25741 | Cycle 1(1): loaded http://localhost:34614/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34614/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:30:33 INFO - PROCESS | 25741 | RSS: Main: 154533888 07:30:33 INFO - PROCESS | 25741 | 07:30:35 INFO - PROCESS | 25741 | Cycle 1(1): loaded http://localhost:34614/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34614/tests/kraken/driver.html?testName=ai-astar) 07:30:35 INFO - PROCESS | 25741 | RSS: Main: 156966912 07:30:35 INFO - PROCESS | 25741 | 07:30:35 INFO - PROCESS | 25741 | __start_tp_report 07:30:35 INFO - PROCESS | 25741 | _x_x_mozilla_page_load 07:30:35 INFO - PROCESS | 25741 | _x_x_mozilla_page_load_details 07:30:35 INFO - PROCESS | 25741 | |i|pagename|runs| 07:30:35 INFO - PROCESS | 25741 | |0;ai-astar;112;107;111;111;113;124;111;114;113;112 07:30:35 INFO - PROCESS | 25741 | |1;audio-beat-detection;156;128;154;167;137;153;162;131;168;129 07:30:35 INFO - PROCESS | 25741 | |2;audio-dft;163;164;163;163;164;163;161;165;171;162 07:30:35 INFO - PROCESS | 25741 | |3;audio-fft;77;76;74;74;82;161;74;74;75;74 07:30:35 INFO - PROCESS | 25741 | |4;audio-oscillator;95;96;142;96;95;96;144;96;102;138 07:30:35 INFO - PROCESS | 25741 | |5;imaging-gaussian-blur;120;115;115;115;114;116;116;116;115;115 07:30:35 INFO - PROCESS | 25741 | |6;imaging-darkroom;146;147;147;147;148;147;146;146;148;147 07:30:35 INFO - PROCESS | 25741 | |7;imaging-desaturate;96;97;97;99;96;96;96;96;96;97 07:30:35 INFO - PROCESS | 25741 | |8;json-parse-financial;58;58;58;58;60;59;59;60;58;58 07:30:35 INFO - PROCESS | 25741 | |9;json-stringify-tinderbox;67;71;68;68;68;69;67;67;67;67 07:30:35 INFO - PROCESS | 25741 | |10;stanford-crypto-aes;83;85;87;87;92;85;87;93;86;85 07:30:35 INFO - PROCESS | 25741 | |11;stanford-crypto-ccm;124;128;114;120;120;127;115;123;122;117 07:30:35 INFO - PROCESS | 25741 | |12;stanford-crypto-pbkdf2;160;162;153;152;163;142;149;150;149;140 07:30:35 INFO - PROCESS | 25741 | |13;stanford-crypto-sha256-iterative;67;67;68;73;70;73;73;68;66;68 07:30:35 INFO - PROCESS | 25741 | __end_tp_report 07:30:35 INFO - PROCESS | 25741 | __start_cc_report 07:30:35 INFO - PROCESS | 25741 | _x_x_mozilla_cycle_collect,740 07:30:35 INFO - PROCESS | 25741 | __end_cc_report 07:30:35 INFO - PROCESS | 25741 | __startTimestamp1453995035380__endTimestamp 07:30:35 INFO - PROCESS | 25741 | 07:30:35 INFO - PROCESS | 25741 | ------- Summary: start ------- 07:30:35 INFO - PROCESS | 25741 | Number of tests: 14 07:30:35 INFO - PROCESS | 25741 | 07:30:35 INFO - PROCESS | 25741 | [#0] ai-astar Cycles:10 Average:112.80 Median:112.50 stddev:4.37 (3.9%) stddev-sans-first:4.62 07:30:35 INFO - PROCESS | 25741 | Values: 112.0 107.0 111.0 111.0 113.0 124.0 111.0 114.0 113.0 112.0 07:30:35 INFO - PROCESS | 25741 | 07:30:35 INFO - PROCESS | 25741 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:155.00 stddev:15.81 (10.2%) stddev-sans-first:16.54 07:30:35 INFO - PROCESS | 25741 | Values: 156.0 128.0 154.0 167.0 137.0 153.0 162.0 131.0 168.0 129.0 07:30:35 INFO - PROCESS | 25741 | 07:30:35 INFO - PROCESS | 25741 | [#2] audio-dft Cycles:10 Average:163.90 Median:163.50 stddev:2.73 (1.7%) stddev-sans-first:2.87 07:30:35 INFO - PROCESS | 25741 | Values: 163.0 164.0 163.0 163.0 164.0 163.0 161.0 165.0 171.0 162.0 07:30:35 INFO - PROCESS | 25741 | 07:30:35 INFO - PROCESS | 25741 | [#3] audio-fft Cycles:10 Average:84.10 Median:74.50 stddev:27.14 (36.4%) stddev-sans-first:28.66 07:30:35 INFO - PROCESS | 25741 | Values: 77.0 76.0 74.0 74.0 82.0 161.0 74.0 74.0 75.0 74.0 07:30:35 INFO - PROCESS | 25741 | 07:30:35 INFO - PROCESS | 25741 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:95.50 stddev:21.76 (22.8%) stddev-sans-first:22.39 07:30:35 INFO - PROCESS | 25741 | Values: 95.0 96.0 142.0 96.0 95.0 96.0 144.0 96.0 102.0 138.0 07:30:35 INFO - PROCESS | 25741 | 07:30:35 INFO - PROCESS | 25741 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:115.50 stddev:1.64 (1.4%) stddev-sans-first:0.67 07:30:35 INFO - PROCESS | 25741 | Values: 120.0 115.0 115.0 115.0 114.0 116.0 116.0 116.0 115.0 115.0 07:30:35 INFO - PROCESS | 25741 | 07:30:35 INFO - PROCESS | 25741 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 07:30:35 INFO - PROCESS | 25741 | Values: 146.0 147.0 147.0 147.0 148.0 147.0 146.0 146.0 148.0 147.0 07:30:35 INFO - PROCESS | 25741 | 07:30:35 INFO - PROCESS | 25741 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.50 stddev:0.97 (1.0%) stddev-sans-first:1.00 07:30:35 INFO - PROCESS | 25741 | Values: 96.0 97.0 97.0 99.0 96.0 96.0 96.0 96.0 96.0 97.0 07:30:35 INFO - PROCESS | 25741 | 07:30:35 INFO - PROCESS | 25741 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.50 stddev:0.84 (1.4%) stddev-sans-first:0.87 07:30:35 INFO - PROCESS | 25741 | Values: 58.0 58.0 58.0 58.0 60.0 59.0 59.0 60.0 58.0 58.0 07:30:35 INFO - PROCESS | 25741 | 07:30:35 INFO - PROCESS | 25741 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:1.29 (1.9%) stddev-sans-first:1.32 07:30:35 INFO - PROCESS | 25741 | Values: 67.0 71.0 68.0 68.0 68.0 69.0 67.0 67.0 67.0 67.0 07:30:35 INFO - PROCESS | 25741 | 07:30:35 INFO - PROCESS | 25741 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.00 stddev:3.16 (3.6%) stddev-sans-first:3.00 07:30:35 INFO - PROCESS | 25741 | Values: 83.0 85.0 87.0 87.0 92.0 85.0 87.0 93.0 86.0 85.0 07:30:35 INFO - PROCESS | 25741 | 07:30:35 INFO - PROCESS | 25741 | [#11] stanford-crypto-ccm Cycles:10 Average:121.00 Median:122.50 stddev:4.74 (3.9%) stddev-sans-first:4.90 07:30:35 INFO - PROCESS | 25741 | Values: 124.0 128.0 114.0 120.0 120.0 127.0 115.0 123.0 122.0 117.0 07:30:35 INFO - PROCESS | 25741 | 07:30:35 INFO - PROCESS | 25741 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:152.00 Median:152.50 stddev:7.83 (5.1%) stddev-sans-first:7.75 07:30:35 INFO - PROCESS | 25741 | Values: 160.0 162.0 153.0 152.0 163.0 142.0 149.0 150.0 149.0 140.0 07:30:35 INFO - PROCESS | 25741 | 07:30:35 INFO - PROCESS | 25741 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:2.75 (4.0%) stddev-sans-first:2.79 07:30:35 INFO - PROCESS | 25741 | Values: 67.0 67.0 68.0 73.0 70.0 73.0 73.0 68.0 66.0 68.0 07:30:35 INFO - PROCESS | 25741 | -------- Summary: end -------- 07:30:35 INFO - PROCESS | 25741 | 07:30:36 INFO - TEST-INFO | 25741: exit 0 07:30:36 INFO - TEST-OK | kraken | took 60404ms 07:30:36 INFO - TEST-START | v8_7 07:30:36 INFO - operating with platform_type : linux_ 07:30:36 INFO - Initialising browser for v8_7 test... 07:30:36 INFO - TEST-INFO | started process 26031 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2i1ATK/profile http://localhost:34614/getInfo.html) 07:30:39 INFO - PROCESS | 26031 | 07:30:39 INFO - PROCESS | 26031 | (process:26103): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:30:40 INFO - PROCESS | 26031 | __metrics Screen width/height:1600/1200 07:30:40 INFO - PROCESS | 26031 | colorDepth:24 07:30:40 INFO - PROCESS | 26031 | Browser inner width/height: 1024/697 07:30:40 INFO - PROCESS | 26031 | __metrics 07:30:41 INFO - PROCESS | 26031 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 07:30:41 INFO - TEST-INFO | 26031: exit 0 07:30:41 INFO - Browser initialized. 07:30:41 INFO - Running cycle 1/1 for v8_7 test... 07:30:41 INFO - TEST-INFO | started process 26153 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2i1ATK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:30:43 INFO - PROCESS | 26153 | 07:30:43 INFO - PROCESS | 26153 | (process:26210): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 07:30:53 INFO - PROCESS | 26153 | RSS: Main: 151617536 07:30:53 INFO - PROCESS | 26153 | 07:31:16 INFO - PROCESS | 26153 | Cycle 1(1): loaded http://localhost:34614/tests/v8_7/run.html (next: http://localhost:34614/tests/v8_7/run.html) 07:31:16 INFO - PROCESS | 26153 | RSS: Main: 152006656 07:31:16 INFO - PROCESS | 26153 | 07:31:16 INFO - PROCESS | 26153 | __start_tp_report 07:31:16 INFO - PROCESS | 26153 | _x_x_mozilla_page_load 07:31:16 INFO - PROCESS | 26153 | _x_x_mozilla_page_load_details 07:31:16 INFO - PROCESS | 26153 | |i|pagename|runs| 07:31:16 INFO - PROCESS | 26153 | |0;Richards;169.664065151001 07:31:16 INFO - PROCESS | 26153 | |1;DeltaBlue;187.93459875963165 07:31:16 INFO - PROCESS | 26153 | |2;Encrypt;272.8512960436562 07:31:16 INFO - PROCESS | 26153 | |3;Decrypt;5191.709844559586 07:31:16 INFO - PROCESS | 26153 | |4;RayTrace;1077.5862068965516 07:31:16 INFO - PROCESS | 26153 | |5;Earley;711.7437722419929 07:31:16 INFO - PROCESS | 26153 | |6;Boyer;12370.37037037037 07:31:16 INFO - PROCESS | 26153 | |7;RegExp;39803.92156862745 07:31:16 INFO - PROCESS | 26153 | |8;Splay;551.762114537445 07:31:16 INFO - PROCESS | 26153 | |9;NavierStokes;4830.917874396136 07:31:16 INFO - PROCESS | 26153 | __end_tp_report 07:31:16 INFO - PROCESS | 26153 | __startTimestamp1453995076355__endTimestamp 07:31:16 INFO - PROCESS | 26153 | 07:31:16 INFO - PROCESS | 26153 | ------- Summary: start ------- 07:31:16 INFO - PROCESS | 26153 | Number of tests: 10 07:31:16 INFO - PROCESS | 26153 | 07:31:16 INFO - PROCESS | 26153 | [#0] Richards Cycles:1 Average:169.66 Median:169.66 stddev:0.00 (0.0%) 07:31:16 INFO - PROCESS | 26153 | Values: 169.7 07:31:16 INFO - PROCESS | 26153 | 07:31:16 INFO - PROCESS | 26153 | [#1] DeltaBlue Cycles:1 Average:187.93 Median:187.93 stddev:0.00 (0.0%) 07:31:16 INFO - PROCESS | 26153 | Values: 187.9 07:31:16 INFO - PROCESS | 26153 | 07:31:16 INFO - PROCESS | 26153 | [#2] Encrypt Cycles:1 Average:272.85 Median:272.85 stddev:0.00 (0.0%) 07:31:16 INFO - PROCESS | 26153 | Values: 272.9 07:31:16 INFO - PROCESS | 26153 | 07:31:16 INFO - PROCESS | 26153 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 07:31:16 INFO - PROCESS | 26153 | Values: 5191.7 07:31:16 INFO - PROCESS | 26153 | 07:31:16 INFO - PROCESS | 26153 | [#4] RayTrace Cycles:1 Average:1077.59 Median:1077.59 stddev:0.00 (0.0%) 07:31:16 INFO - PROCESS | 26153 | Values: 1077.6 07:31:16 INFO - PROCESS | 26153 | 07:31:16 INFO - PROCESS | 26153 | [#5] Earley Cycles:1 Average:711.74 Median:711.74 stddev:0.00 (0.0%) 07:31:16 INFO - PROCESS | 26153 | Values: 711.7 07:31:16 INFO - PROCESS | 26153 | 07:31:16 INFO - PROCESS | 26153 | [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 07:31:16 INFO - PROCESS | 26153 | Values: 12370.4 07:31:16 INFO - PROCESS | 26153 | 07:31:16 INFO - PROCESS | 26153 | [#7] RegExp Cycles:1 Average:39803.92 Median:39803.92 stddev:0.00 (0.0%) 07:31:16 INFO - PROCESS | 26153 | Values: 39803.9 07:31:16 INFO - PROCESS | 26153 | 07:31:16 INFO - PROCESS | 26153 | [#8] Splay Cycles:1 Average:551.76 Median:551.76 stddev:0.00 (0.0%) 07:31:16 INFO - PROCESS | 26153 | Values: 551.8 07:31:16 INFO - PROCESS | 26153 | 07:31:16 INFO - PROCESS | 26153 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 07:31:16 INFO - PROCESS | 26153 | Values: 4830.9 07:31:16 INFO - PROCESS | 26153 | -------- Summary: end -------- 07:31:16 INFO - PROCESS | 26153 | 07:31:17 INFO - TEST-INFO | 26153: exit 0 07:31:17 INFO - TEST-OK | v8_7 | took 40945ms 07:31:17 INFO - SUITE-END | took 1211s 07:31:17 INFO - Completed test suite (00:20:11) 07:31:17 INFO - Working with test: dromaeo_css 07:31:17 INFO - Generating results file: dromaeo_css 07:31:17 INFO - Working with test: kraken 07:31:17 INFO - Generating results file: kraken 07:31:17 INFO - javascript benchmark 07:31:17 INFO - Working with test: v8_7 07:31:17 INFO - Generating results file: v8_7 07:31:17 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:31:17 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 07:31:17 INFO - process_Request line: dromaeo_css 6847.34 graph.html#tests=[[72,63,43]] 07:31:17 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:31:17 INFO - process_Request line: kraken 1534.30 graph.html#tests=[[232,63,43]] 07:31:17 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:31:17 INFO - process_Request line: v8_7 20619.31 graph.html#tests=[[230,63,43]] 07:31:17 INFO - RETURN: dromaeo_css: 6847.34 07:31:17 INFO - RETURN: kraken: 1534.30 07:31:17 INFO - RETURN: v8_7: 20619.31 07:31:17 INFO - javascript benchmark 07:31:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3129.530570414436, 3177.5233714942765, 3183.936321273575, 3187.7609179311544, 3221.581194444722, 5103.591712662987, 5212.21816727491, 5223.555997740187, 5243.711595862231, 5281.445448227938, 5079.466656001122, 5189.740512974355, 5275.446078161795, 5309.522143007129, 5321.840344789663, 4739.502352253024, 4813.78337974792, 4830.661853670227, 4834.879128021792, 4922.581580565657, 4825.010872771073, 4833.275008748698, 4843.104025755247, 4904.337914381548, 4960.627952903528, 4674.509176536449, 4737.50256223095, 4756.0, 4831.613470922318, 4862.246351815475, 4769.570738633505, 4770.904581908342, 4770.95229047712, 4786.593139583139, 4803.3035209894715, 4697.600703940135, 4758.524147585248, 4767.451743049559, 4788.569028787426, 4802.951970480285, 4913.8771530711665, 4995.325631039799, 5050.898982020339, 5053.6967781932835, 5123.538881500683, 5577.609567330289, 5613.971930140323, 5623.690697011662, 5637.069883469223, 5665.036943719578, 5629.915551266734, 5631.324241091095, 5641.492265696066, 5648.661080335193, 5651.547876169897, 5198.246254293106, 5250.97374513125, 5273.9736301318635, 5275.340582427197, 5290.497402746733, 5768.0, 5828.766849326064, 5831.475167234969, 5842.123681447817, 5870.3249126350165, 5544.306961629796, 5566.443355664401, 5569.331680198321, 5573.164025396142, 5575.888482230333, 5409.513143817076, 5479.424660410679, 5541.5289700375115, 5577.05190117681, 5640.294963129609, 5555.1667249912025, 5575.99632066232, 5578.442155784389, 5596.636218645775, 5624.156376543551, 5540.113581826889, 5545.750441230154, 5558.666480011212, 5599.720013999284, 5616.241807356037, 4244.0663054128045, 4350.1734670412525, 4364.607185353333, 4405.471343438808, 4416.33754936762, 3852.768833869921, 3910.687145028391, 3923.391874259494, 3924.3132451820816, 3956.228535435562, 5261.868453288622, 5303.628745987744, 5312.601554883399, 5313.149896016619, 5313.229581710708, 5460.672359658433, 5573.0, 5648.0, 5695.7152142392715, 5753.597248192586, 5347.0, 5354.651947623392, 5362.1420572708175, 5378.381486129145, 5389.0, 4876.0, 4884.7069175849565, 4889.413270407503, 4893.119238537026, 4934.654574179773, 5629.774809007594, 5665.745041473061, 5714.485696287354, 5716.714164291852, 5717.628354156966, 5480.506754392124, 5501.862453438696, 5504.834854954358, 5661.122526008476, 5755.884882302415, 5829.125631155361, 5869.6771677558145, 5896.70516474166, 5906.734196961061, 5911.261092363455, 5564.554835613222, 5565.916511252253, 5594.468525490072, 5600.523955463831, 5619.550435965195, 5493.505584497255, 5521.4478552144465, 5583.106702927512, 5642.633228840113, 5692.886142277049, 5498.120300751861, 5533.335999680065, 5557.72211389437, 5562.471565201299, 5568.805091821767, 5472.890542189213, 5473.17902314656, 5503.972480137573, 5514.420985796433, 5531.806386776604, 5288.233206185158, 5317.867053323698, 5340.465953404629, 5351.411344752152, 5433.402325744244, 5518.034343989705, 5530.585206109638, 5548.223248745098, 5575.247341608993, 5575.832725018256, 5398.946010539844, 5435.809746658848, 5450.972745136249, 5480.972595136999, 5503.834884953458], "unit": "score", "name": "dojo.html", "value": 5190.23745948843}, {"lowerIsBetter": false, "replicates": [506.38221369928675, 525.1702310349648, 547.1000204663329, 563.228377123341, 568.3833041150351, 27366.315842103933, 35342.64657353426, 35441.11397215068, 35664.286714265734, 35818.10454738633, 38155.0, 38688.41967370492, 38693.419598706045, 38743.418848717294, 38751.806240968755, 8375.37184711146, 8387.329013678891, 8527.573621318941, 8539.146085391441, 8576.957115214447, 8371.95814020929, 8462.36532260083, 8465.74602761915, 8482.618282177316, 8515.403921725481, 8470.44942078766, 8488.0, 8498.490090594552, 8515.829683406328, 8529.786755331104, 8371.204735550144, 8452.197041281068, 8484.872726909101, 8662.350323725683, 8702.347323950666, 8541.914580854174, 8664.133586641348, 8735.868961965512, 8760.649574017032, 8803.603837827313, 38193.0, 38661.806690966645, 38673.613263867286, 38877.61122388768, 38985.610143898484, 3152.5586417901513, 3198.9200269993203, 3297.8021318720953, 3778.924421511582, 3872.67082298005, 29305.706942930512, 29526.0, 29876.0, 30255.0, 30717.0, 3930.4693866327966, 3937.684985201177, 4019.417184508259, 4086.427900093989, 4121.5878412158545, 212576.0, 213966.0, 214856.0, 263184.0, 271442.6427867868, 58229.70885145632, 58635.70682146562, 59095.70452147798, 59248.7037564818, 59382.0, 54614.0, 54746.72626636921, 54930.0, 55140.72429637906, 55154.0, 13502.122362046435, 13562.59312220635, 13628.250446225553, 13646.385912633956, 13679.589612311647, 10267.332623379456, 10298.3820970742, 10299.17606591471, 10300.587976480856, 10306.845397319046, 20482.38552843417, 20566.69149962752, 20667.17331306761, 20751.8962405187, 20815.271465498634, 7883.684652613946, 8116.553589552514, 8156.796080098045, 8237.46456480339, 8272.503649781032, 919.4529255093208, 952.3761935931975, 977.8826540815147, 981.9361741486781, 1029.5984566019258, 28580.285492862844, 28804.29897020449, 28901.710982890323, 29365.706342936726, 29476.705232947395, 1056.5404049238605, 1161.488944864274, 1174.9588764393377, 1204.8192771084407, 1222.93273869938, 14930.925345373204, 15003.474878379204, 15315.15766632846, 16039.67920641604, 16398.754018689728, 297683.0, 299512.0, 299879.0, 300440.0, 301437.0, 54618.72690636521, 55307.44692553103, 55363.446365536634, 55382.446175538535, 55555.44444555583, 1341.3494455189225, 1344.0860215053858, 1347.3600039981127, 1348.2382453913508, 1463.4073200353873, 29216.7078329214, 30140.69859301379, 30421.0, 30846.383072338875, 30909.690903090683, 49137.508624913295, 50004.499954999985, 50286.245706313704, 50316.74841625769, 50461.0, 292759.0, 293835.0, 294704.0, 296575.0, 296989.0, 42313.153736925706, 42497.78751106225, 42581.57418425776, 43033.56966430296, 43649.34525982176, 37976.0, 37987.43018854664, 38659.6134038656, 38978.2204355917, 39119.60880391159, 32731.181720456225, 32973.17567060843, 35377.82311088428, 36490.452643210905, 36547.81726091352, 35574.46638300376, 36552.26895462129, 36700.63299367079, 36866.8156659215, 37049.25901482009, 35184.47223291704, 35393.82303088468, 35624.287514250085, 37443.25113497769, 38208.61791382162, 28764.0, 30273.24316892095, 31276.0, 32456.51315230226, 33144.0, 24447.87776061108, 24713.876430617733, 24791.62812557777, 25207.11775087863, 25329.49341013206], "unit": "score", "name": "ext.html", "value": 18309.471776486647}, {"lowerIsBetter": false, "replicates": [358.8941262327613, 361.19453618430896, 361.87153560486024, 363.23176481741115, 370.14311868025504, 16033.759493607591, 16802.579935501588, 16821.74767378489, 17191.054492002935, 17576.912115439405, 10522.842157367626, 10884.945575272131, 14935.551933442013, 15239.542813715607, 15266.770998435033, 4737.90524189516, 4886.144924638192, 5410.404855465896, 5413.485718856722, 5414.675119492823, 4286.863981045026, 5345.33183352081, 5356.517913387795, 5391.029614669358, 5401.297831281928, 5266.078436273656, 5312.495312945264, 5362.705051222181, 5440.347158341005, 5452.700101494416, 4747.572718455355, 4914.385701787277, 5026.623003274751, 5408.945910540903, 5418.756155972991, 4693.88265293367, 4744.169770290186, 4745.59662428694, 4746.952530474686, 4749.501302363271, 14696.853031469762, 19353.225870965143, 19919.50201244966, 19927.0, 20041.1983520659, 2188.8248940084754, 2207.150247154841, 2369.9763002369928, 2566.4995325911455, 2819.9013034543896, 8752.912470875273, 9203.309751768644, 9325.673601423918, 9408.388454750488, 9727.854082188773, 1873.9063046847739, 1883.7456943312613, 1936.5352315444334, 1942.6114777044647, 1965.1549833571557, 58337.416625833626, 59298.70350648262, 60710.0, 61178.08232876511, 61263.69368153175, 10192.694219173436, 10200.591976320864, 10325.173986081096, 10351.223658225663, 10434.321769084985, 11696.824547631792, 11852.348120853263, 12298.446569904376, 13455.125416847874, 13567.932160339134, 5557.360903496069, 5724.914126288109, 6228.781992630236, 7048.929510704827, 7055.858882822417, 6741.831454213586, 6752.291009444036, 6753.054572359873, 6763.458923286125, 6805.693743781443, 4178.811953462041, 4349.369341445473, 4391.231534481453, 4397.548808893058, 4489.461264648197, 1699.3431404380876, 1756.938507152269, 1762.691528982423, 1846.3168627607872, 1864.822841830024, 870.5647176411794, 881.7090360181124, 889.6174644902754, 946.4841661294611, 958.6165533786541, 16090.195490225442, 16186.676266474604, 16284.26720797567, 16532.09073500945, 16623.750643740354, 868.561376504861, 891.2780647675404, 909.417972497602, 928.7770934975557, 951.7620594851287, 8677.956610216908, 9110.088991100836, 9347.158755712018, 9953.900460995297, 10079.647212347532, 366804.0, 378733.0, 379456.0, 526991.0, 530936.0, 61286.0, 64077.67961160164, 64312.0, 64636.353636463034, 72347.63826180836, 1111.9833202501968, 1133.4955944604737, 1143.0626885953604, 1143.3140115930541, 1145.1811954452605, 9930.106290433896, 10130.544125514516, 10157.136643385395, 14908.62728431798, 15114.09315441077, 31976.360472789947, 32100.357992839545, 32613.510797337585, 34126.0, 35927.10182245465, 46718.299225510964, 47368.052638947716, 47432.2885156716, 47805.282920756916, 48696.513034870615, 9698.9030109698, 10204.642837500653, 10437.373757574569, 10614.89385106139, 10652.254342195973, 11806.0, 11981.0, 12067.155299128977, 12312.50749970027, 12420.441080151595, 10489.580416783243, 10558.472076395996, 10726.141908647445, 11064.446777660924, 11069.833952490559, 10320.329178603668, 10635.308704934154, 10932.726681833017, 11010.614628487965, 11237.269577477438, 7036.437085033082, 7089.468289878177, 7104.360607545345, 7495.775126746206, 10913.836292455779, 9316.254699624149, 9697.17472525829, 9724.611015559582, 9885.0, 9890.85163722559, 10253.538590763583, 10354.275200735876, 10389.428581428094, 10424.322419042737, 10543.15654747603], "unit": "score", "name": "jquery.html", "value": 8120.535705341074}, {"lowerIsBetter": false, "replicates": [1475.6827282134343, 1481.6147801571594, 1637.2632315458047, 1762.1101393714318, 1787.6424715056992, 7561.470697051209, 7703.46075774696, 7724.188960159173, 7895.64469598868, 7924.683012679493, 7821.648025838851, 7834.529928204312, 7841.059072911258, 7886.566238856861, 7910.841783164333, 2328.860268383898, 2347.295811256625, 2359.4809141988735, 2361.1499860050367, 2365.1012615206196, 2291.0835665733757, 2293.7935585797277, 2312.144506532585, 2329.406001469623, 2332.591796435617, 2249.3814201094665, 2286.131270117353, 2289.67944487771, 2311.4452531392512, 2322.1640209524644, 2165.372042107787, 2267.161150374364, 2269.3986093685185, 2300.6088964875926, 2301.562703086425, 2232.8771917544527, 2234.5084081502046, 2243.932682019542, 2248.123231939545, 2249.280230326296, 7940.444168908179, 7948.0, 7985.560794156319, 7993.120756716757, 8029.799255018613, 4675.275332323496, 4782.880427989293, 4786.569208771228, 4793.688410253358, 4828.879278018043, 3048.3141293209073, 3106.2855543225187, 3211.8394080295893, 3231.0952933178746, 3249.788763730374, 1029.12524354299, 1048.774513479598, 1059.4596755654595, 1063.4682658670665, 1949.8788196786904, 10522.31604945676, 10552.0, 10562.947185264102, 10567.524461399178, 10601.893981060168, 4144.129732756095, 4197.034682023091, 4200.6429453496185, 4300.935485967713, 4309.84915527955, 8517.488950662857, 8538.316934645214, 8627.439216451035, 8641.654333826702, 8670.0, 4624.884377890579, 4649.279361698942, 4668.276417155346, 4673.345731597579, 4678.836240731626, 4274.700770946066, 4277.508086570084, 4320.827166913351, 4320.913581728348, 4342.131573685276, 3307.4046671598862, 3346.113279980807, 3357.764956453074, 3412.7952322860706, 3428.7428442866885, 938.0900526489295, 1003.1874181912674, 1029.8455231715302, 1041.416806588313, 1044.4307852220406, 910.8724778531011, 1068.7969285835666, 1092.748667806409, 1169.6783384569312, 1301.9218846869219, 7127.10911136108, 7155.284471552803, 7212.350888420067, 7237.493375463667, 7268.418526517866, 616.140484024783, 618.8576627375729, 630.1209812311799, 635.8569321902535, 768.727101878825, 5367.516923476827, 5534.418886016911, 5679.062954612443, 5692.174634678031, 5719.113537401709, 9394.765130871647, 9659.034096590285, 9667.226621870233, 9670.90329096714, 9733.561989710339, 9424.246060315158, 9513.0, 9514.619415223451, 9582.760430989281, 9594.712158635251, 7356.742514011984, 7470.103587569418, 7485.0, 7505.774826755206, 7540.17058123595, 7125.144074604507, 7133.215346312006, 7175.647013134367, 7229.277072292729, 7270.309320614533, 8432.45189062709, 8435.32517398619, 8538.871916921375, 8622.655093796178, 8642.697505587274, 8736.78158046054, 8817.647294108165, 8836.204741573289, 8863.202311791712, 8869.334799889904, 6655.500837437308, 6709.161354830646, 6722.596644201363, 6737.62943038118, 6779.593224406552, 7240.601766902871, 7251.383632391306, 7356.0, 7549.584772837547, 7618.390528757797, 6899.310068993061, 6963.7214511421, 7026.8945965809535, 7037.648117593997, 7109.786706398816, 6258.0, 6692.096566963398, 6881.380675739208, 6979.511434199558, 7018.473614479037, 6724.361185687352, 6772.187337519529, 6787.89818152738, 6795.38841504267, 6835.965820170867, 6346.619202847844, 6348.714307856065, 6389.584676995981, 6418.55070145104, 6436.871262574816, 6487.967560162169, 6516.055172000129, 6522.249941256816, 6553.311902250195, 6581.638009909501], "unit": "score", "name": "mootools.html", "value": 4424.170394684369}, {"lowerIsBetter": false, "replicates": [327.322442543934, 329.99670003299957, 330.077433573163, 330.7420212234458, 341.344618332801, 6265.373462653738, 6283.685815709214, 6314.8737025259525, 6330.082138089974, 6464.644444555547, 6259.37406259375, 6310.305866354709, 6316.147320111783, 6328.303886572473, 6366.108744775735, 4749.76251187441, 4791.305260737191, 4797.352357431737, 4804.159272127364, 4805.0, 4808.759562021903, 4809.975950120262, 4812.470628230892, 4812.639052071091, 4828.927566086511, 4636.605888499482, 4710.175719249135, 4711.6466265030085, 4714.622830173595, 4718.764061796914, 4709.434867815867, 4710.882227944312, 4713.363695901044, 4735.479097299294, 4740.5733483986605, 4049.979750101231, 4067.7966101694797, 4068.5524592294823, 4070.0842310480202, 4088.325426304656, 5934.228550288478, 5965.4929331006915, 5979.940200597982, 5988.730507127146, 6004.0693692477735, 5380.408155102936, 5473.17902314652, 5474.72626368684, 5486.972565137189, 5500.092484740013, 6617.139771829679, 6618.238902526223, 6636.966815165942, 6657.733690652368, 6663.300353462865, 4454.866354009385, 4456.041950980522, 4479.081788233404, 4486.685931984763, 4489.326601009842, 6768.69540870662, 6923.0, 6952.895706564405, 6993.405560527362, 7003.15962084548, 4576.88557786058, 4585.312203169551, 4590.540945905383, 4593.6095431888, 4605.677602567788, 4625.976870115628, 4636.536346365337, 4644.326572646947, 4647.767611619473, 4648.790804413809, 5432.2123292123215, 5441.782328706887, 5446.509814116748, 5456.590755693339, 5460.918086228709, 6476.125723027331, 6692.163479565054, 6720.630365329954, 6752.5273230874345, 6757.729690812411, 1611.025329675553, 1634.207409406437, 1654.1729135432283, 1659.7510373443838, 1660.9750853737203, 1100.5212732461405, 1111.183280288987, 1112.6773235761539, 1114.0641860836936, 1122.93262404256, 6252.843678908063, 6267.2792628847355, 6290.276618188876, 6294.716737746812, 6341.587796793194, 6746.527743057939, 6774.051632771318, 6787.321267873272, 6796.286389929085, 6812.420944219698, 6132.601380910227, 6244.500439964882, 6247.75008999644, 6306.747730090745, 6328.7468501260355, 3650.470681751131, 3672.5776535698737, 3683.631636836295, 3703.185299234164, 3712.7957962311793, 7124.786256412316, 7126.144862616519, 7130.679119439637, 7143.178534468499, 7182.174049984214, 6847.726090956406, 7006.264342244093, 7012.439004879598, 7015.929840701528, 7033.226345102034, 7144.0, 7144.214136444987, 7146.714131434788, 7152.892706609405, 7161.641917904084, 6783.728650853911, 6791.0, 6822.454203663596, 6827.0, 6841.452683785185, 6633.668316584055, 6680.63256520896, 6726.192856857013, 6743.35938085881, 6748.7300507979135, 7023.33278338557, 7054.08296921397, 7113.57318560888, 7117.252688467636, 7152.642367881481, 4591.747453890068, 4611.93082103762, 4613.19269127908, 4615.79228934692, 4616.746078965555, 6758.256591774999, 6823.761168359084, 6853.314668533107, 6863.656817159222, 6982.406495447741, 6794.422474089758, 6800.217974932946, 6826.249112597709, 6831.6242606657115, 6868.381845633917, 6820.488463365168, 6830.419414349637, 6836.111305530449, 6839.692213850488, 6840.384365407137, 6501.1548498694865, 6583.078369028436, 6614.768483103068, 6631.767888123893, 6655.633940133339, 6748.257691654012, 6753.729850805913, 6778.051072849904, 6835.4189893859575, 6845.110135682528, 6575.638339891352, 6635.402813746786, 6644.235912870082, 6655.301193374626, 6658.5671931324305], "unit": "score", "name": "prototype.html", "value": 4985.68109272769}, {"lowerIsBetter": false, "replicates": [792.3977776889562, 806.8789681547767, 808.123186342818, 825.257268458387, 855.2815634866711, 12344.13591048627, 12668.113232073736, 12701.872981270197, 12723.872761272385, 12743.171693839893, 11407.54369825208, 11503.367314797704, 11571.247868888537, 11580.189386742932, 11583.710407239823, 815.4495715392102, 822.7901885019312, 829.7635173975418, 830.4104086098877, 830.7466222802043, 810.068421315486, 815.4984684419098, 816.2368185746317, 817.1215942861418, 820.7209548753423, 855.2687452228348, 855.4012191465968, 855.4396870050095, 858.4891989266408, 861.2507118806647, 849.4223927729141, 850.4897061762955, 851.3019324154196, 855.8930133733284, 856.8372009318209, 621.1335187413578, 626.9811905642838, 627.6861569215392, 628.3433811666819, 630.3759278314482, 12528.74942501154, 12683.112182147253, 12685.17546359493, 12724.045696572794, 12741.936290318488, 10875.184361172944, 10997.450127493594, 11021.779564408747, 11181.0, 11454.48454819535, 9695.854562181574, 9764.90235097647, 9774.5601447935, 9785.902140978571, 9876.308658393915, 3474.2530355973336, 3549.680528752425, 3588.2464682416726, 3678.337899178147, 3743.8315275812383, 41256.79371603153, 41699.0, 45565.31652025222, 46438.30342544865, 48158.27762583564, 9739.464329461805, 9876.753081172885, 9936.80126397468, 10183.236257280734, 10345.741356465998, 15182.620434489227, 15342.539723808304, 15357.155356455502, 15375.0, 15376.308066137051, 7210.567365957954, 7383.852322953511, 7558.433117516208, 7585.393168546503, 7868.055833300041, 3845.576986531479, 3906.335922893058, 3949.5458022327225, 4002.5597184309704, 4067.9389809152885, 3075.2926826829953, 3111.3932783107075, 3114.641816191167, 3118.672539383332, 3127.9530807037913, 572.5963195946847, 572.6707143392566, 581.970901454934, 583.151514546334, 583.8657108864985, 476.2879495154697, 507.778792005228, 603.5081408651935, 622.5082185073741, 664.869721473497, 7926.8810967835525, 7933.722319718782, 8020.238077382639, 8199.344052475788, 8346.081930987586, 572.9026065568863, 613.4049971527611, 640.4140211706236, 644.8742495213482, 654.456800855289, 3763.8306276217636, 3863.96136038636, 4238.703290769617, 4240.84836854119, 4292.935605965913, 50533.494665053615, 52451.47548524542, 52597.0, 52627.0, 52894.0, 46760.76619616948, 46840.53159468362, 47329.29006064912, 48100.0, 48210.276845847344, 49481.0, 49573.504264956886, 50253.0, 50460.0, 51029.74485127625, 8441.240288374076, 8691.0, 8738.169873861973, 8793.648254069765, 8875.778105547413, 34200.14499637529, 34320.82839585786, 34677.65322346845, 35177.64822351744, 35257.82371088128, 39175.608243917195, 39842.60157398389, 42750.144997100506, 43487.78256108699, 43968.12063758771, 10080.798384032132, 10210.336328138646, 10225.539850706587, 10228.07947284748, 10280.0, 11642.24325418879, 11859.229150105215, 11876.584319548774, 12472.376381181086, 12636.0, 10290.228232882415, 10410.47947602632, 10562.049415552638, 10562.207834412297, 11049.558017679203, 10421.426821524889, 10460.320079195133, 10539.26225164231, 10586.629467968583, 10818.783624327627, 9775.560099795668, 9923.1069203772, 10042.674394865224, 10154.543045563116, 10285.640002599874, 8902.910970890209, 8933.28533717314, 9002.639894404412, 9130.041345658876, 9165.083491650781, 8570.4000719949, 8734.213920747163, 8789.384743067923, 9465.66870159541, 9804.558794854105], "unit": "score", "name": "yui.html", "value": 6054.64890612396}], "name": "dromaeo_css", "value": 6847.337336102047}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 111.0, 111.0, 113.0, 124.0, 111.0, 114.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.8}, {"lowerIsBetter": true, "replicates": [156.0, 128.0, 154.0, 167.0, 137.0, 153.0, 162.0, 131.0, 168.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 163.0, 163.0, 164.0, 163.0, 161.0, 165.0, 171.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.9}, {"lowerIsBetter": true, "replicates": [77.0, 76.0, 74.0, 74.0, 82.0, 161.0, 74.0, 74.0, 75.0, 74.0], "unit": "score", "name": "audio-fft", "value": 84.1}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 142.0, 96.0, 95.0, 96.0, 144.0, 96.0, 102.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [120.0, 115.0, 115.0, 115.0, 114.0, 116.0, 116.0, 116.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 115.7}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 148.0, 147.0, 146.0, 146.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 99.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 58.0, 58.0, 60.0, 59.0, 59.0, 60.0, 58.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 68.0, 68.0, 68.0, 69.0, 67.0, 67.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 87.0, 87.0, 92.0, 85.0, 87.0, 93.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.0}, {"lowerIsBetter": true, "replicates": [124.0, 128.0, 114.0, 120.0, 120.0, 127.0, 115.0, 123.0, 122.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.0}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 153.0, 152.0, 163.0, 142.0, 149.0, 150.0, 149.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 152.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 73.0, 70.0, 73.0, 73.0, 68.0, 66.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1534.3000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.664065151001], "unit": "score", "name": "Richards", "value": 208.0699880000001}, {"lowerIsBetter": false, "replicates": [187.93459875963165], "unit": "score", "name": "DeltaBlue", "value": 351.8138780000001}, {"lowerIsBetter": false, "replicates": [272.8512960436562], "unit": "score", "name": "Encrypt", "value": 975.5533650000004}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1077.5862068965516], "unit": "score", "name": "RayTrace", "value": 686.7097920000001}, {"lowerIsBetter": false, "replicates": [711.7437722419929], "unit": "score", "name": "Earley", "value": 936.3805150000001}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [39803.92156862745], "unit": "score", "name": "RegExp", "value": 22.88681527093598}, {"lowerIsBetter": false, "replicates": [551.762114537445], "unit": "score", "name": "Splay", "value": 147.69227145708578}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 20619.310918706604}]} 07:31:17 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20619.31"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1534.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6847.34"}}} 07:31:17 INFO - Return code: 0 07:31:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 07:31:17 INFO - # TBPL SUCCESS # 07:31:17 INFO - Running post-action listener: _resource_record_post_action 07:31:17 INFO - Running post-run listener: _resource_record_post_run 07:31:18 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 65536; Write bytes: 550191104; Read time: 428; Write time: 440644 07:31:18 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 49152; Write bytes: 236404736; Read time: 344; Write time: 262832 07:31:18 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 16384; Write bytes: 313188352; Read time: 84; Write time: 177812 07:31:18 INFO - Running post-run listener: _upload_blobber_files 07:31:18 INFO - Blob upload gear active. 07:31:18 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 07:31:18 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 07:31:18 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'] 07:31:18 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 07:31:19 INFO - (blobuploader) - INFO - Open directory for files ... 07:31:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:31:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:31:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:20 INFO - (blobuploader) - INFO - Done attempting. 07:31:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:31:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:31:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:31:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:31:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:31:21 INFO - (blobuploader) - INFO - Done attempting. 07:31:21 INFO - (blobuploader) - INFO - Iteration through files over. 07:31:21 INFO - Return code: 0 07:31:21 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 07:31:21 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 07:31:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3b2b18fad93d1c652b554bc7fa407e0b85a8444632de2c8f29d9cf6c5e95b877072d877a8417fd02a546704e230acb4e9ee3ada8a004ab8428166336876c15f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9f7b56ca74dcab5b3ad657089fcc455f06b7ac9cefa5d529413f5587e15611b8314f8ef3718b1aaf3ab4a84480215c955ce9a675aa91d98a37203bebfc1367f3"} 07:31:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 07:31:21 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 07:31:21 INFO - Contents: 07:31:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3b2b18fad93d1c652b554bc7fa407e0b85a8444632de2c8f29d9cf6c5e95b877072d877a8417fd02a546704e230acb4e9ee3ada8a004ab8428166336876c15f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9f7b56ca74dcab5b3ad657089fcc455f06b7ac9cefa5d529413f5587e15611b8314f8ef3718b1aaf3ab4a84480215c955ce9a675aa91d98a37203bebfc1367f3"} 07:31:21 INFO - Running post-run listener: copy_logs_to_upload_dir 07:31:21 INFO - Copying logs to upload dir... 07:31:21 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 07:31:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.180804 ========= master_lag: 4.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-28 07:31:25.539878) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-28 07:31:25.543920) ========= 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=d2a8c569965ab8367867b893000001a1-1453993716.460711-66607391 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/3b2b18fad93d1c652b554bc7fa407e0b85a8444632de2c8f29d9cf6c5e95b877072d877a8417fd02a546704e230acb4e9ee3ada8a004ab8428166336876c15f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9f7b56ca74dcab5b3ad657089fcc455f06b7ac9cefa5d529413f5587e15611b8314f8ef3718b1aaf3ab4a84480215c955ce9a675aa91d98a37203bebfc1367f3"} build_url:https://queue.taskcluster.net/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/artifacts/public/build/firefox-47.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/RRN8uB2RQbGmQa0A9JI4Hw/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/3b2b18fad93d1c652b554bc7fa407e0b85a8444632de2c8f29d9cf6c5e95b877072d877a8417fd02a546704e230acb4e9ee3ada8a004ab8428166336876c15f2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9f7b56ca74dcab5b3ad657089fcc455f06b7ac9cefa5d529413f5587e15611b8314f8ef3718b1aaf3ab4a84480215c955ce9a675aa91d98a37203bebfc1367f3"}' ========= master_lag: 0.15 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-28 07:31:25.701134) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 07:31:25.701478) ========= 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=d2a8c569965ab8367867b893000001a1-1453993716.460711-66607391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-28 07:31:25.717309) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-28 07:31:25.717666) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-28 07:31:25.717984) ========= ========= Total master_lag: 4.38 =========