builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1453755606.19 results: success (0) buildid: 20160125103134 builduid: a8303e4d660347958e476d1f2509d06e revision: 1b7625c90538a95413f7ca1910f4ec791eff82b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:06.190719) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:06.191151) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:06.191451) ========= 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=6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.003579 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:06.212324) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:06.212749) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:06.225755) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:06.226186) ========= 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=6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.002828 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:06.272979) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:06.273290) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:06.276714) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:06.277012) ========= 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=6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 13:00:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 210M=0s 2016-01-25 13:00:06 (210 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112226 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:06.404045) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:06.404389) ========= 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=6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022641 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:06.454676) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:06.455065) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 1b7625c90538a95413f7ca1910f4ec791eff82b5 --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 1b7625c90538a95413f7ca1910f4ec791eff82b5 --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=6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 13:00:06,650 truncating revision to first 12 chars 2016-01-25 13:00:06,650 Setting DEBUG logging. 2016-01-25 13:00:06,650 attempt 1/10 2016-01-25 13:00:06,650 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/1b7625c90538?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 13:00:07,230 unpacking tar archive at: mozilla-inbound-1b7625c90538/testing/mozharness/ program finished with exit code 0 elapsedTime=0.873707 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:07.345383) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:07.348764) ========= echo 1b7625c90538a95413f7ca1910f4ec791eff82b5 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'1b7625c90538a95413f7ca1910f4ec791eff82b5'] 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=6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 1b7625c90538a95413f7ca1910f4ec791eff82b5 program finished with exit code 0 elapsedTime=0.004624 script_repo_revision: '1b7625c90538a95413f7ca1910f4ec791eff82b5' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:07.402130) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:07.402990) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 13:00:07.416301) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-25 13:00:07.416622) ========= /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=6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:00:07 INFO - MultiFileLogger online at 20160125 13:00:07 in /builds/slave/test-pgo 13:00:07 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 13:00:07 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 13:00:07 INFO - {'append_to_log': False, 13:00:07 INFO - 'base_work_dir': '/builds/slave/test-pgo', 13:00:07 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 13:00:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 13:00:07 INFO - 'branch': 'Mozilla-Inbound', 13:00:07 INFO - 'buildbot_json_path': 'buildprops.json', 13:00:07 INFO - 'config_files': ('talos/linux_config.py',), 13:00:07 INFO - 'default_actions': ('clobber', 13:00:07 INFO - 'read-buildbot-config', 13:00:07 INFO - 'download-and-extract', 13:00:07 INFO - 'populate-webroot', 13:00:07 INFO - 'create-virtualenv', 13:00:07 INFO - 'install', 13:00:07 INFO - 'run-tests'), 13:00:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:00:07 INFO - 'download_minidump_stackwalk': True, 13:00:07 INFO - 'download_symbols': 'ondemand', 13:00:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:00:07 INFO - 'tooltool.py': '/tools/tooltool.py', 13:00:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:00:07 INFO - '/tools/misc-python/virtualenv.py')}, 13:00:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:00:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:00:07 INFO - 'installer_path': 'installer.exe', 13:00:07 INFO - 'log_level': 'info', 13:00:07 INFO - 'log_name': 'talos', 13:00:07 INFO - 'log_to_console': True, 13:00:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:00:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:00:07 INFO - 'opt_config_files': (), 13:00:07 INFO - 'pip_index': False, 13:00:07 INFO - 'sps_profile': False, 13:00:07 INFO - 'sps_profile_interval': 0, 13:00:07 INFO - 'suite': 'dromaeojs-e10s', 13:00:07 INFO - 'system_bits': '32', 13:00:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:00:07 INFO - 'title': 'talos-linux64-ix-050', 13:00:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:00:07 INFO - 'use_talos_json': True, 13:00:07 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 13:00:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:00:07 INFO - 'work_dir': 'build'} 13:00:07 INFO - ##### 13:00:07 INFO - ##### Running clobber step. 13:00:07 INFO - ##### 13:00:07 INFO - Running pre-action listener: _resource_record_pre_action 13:00:07 INFO - Running main action method: clobber 13:00:07 INFO - rmtree: /builds/slave/test-pgo/build 13:00:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 13:00:08 INFO - Running post-action listener: _resource_record_post_action 13:00:08 INFO - ##### 13:00:08 INFO - ##### Running read-buildbot-config step. 13:00:08 INFO - ##### 13:00:08 INFO - Running pre-action listener: _resource_record_pre_action 13:00:08 INFO - Running main action method: read_buildbot_config 13:00:08 INFO - Using buildbot properties: 13:00:08 INFO - { 13:00:08 INFO - "project": "", 13:00:08 INFO - "product": "firefox", 13:00:08 INFO - "script_repo_revision": "production", 13:00:08 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 13:00:08 INFO - "repository": "", 13:00:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 13:00:08 INFO - "buildid": "20160125103134", 13:00:08 INFO - "pgo_build": "True", 13:00:08 INFO - "basedir": "/builds/slave/test-pgo", 13:00:08 INFO - "buildnumber": 348, 13:00:08 INFO - "slavename": "talos-linux64-ix-050", 13:00:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 13:00:08 INFO - "platform": "ubuntu64_hw", 13:00:08 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 13:00:08 INFO - "branch": "mozilla-inbound", 13:00:08 INFO - "repo_path": "integration/mozilla-inbound", 13:00:08 INFO - "revision": "1b7625c90538a95413f7ca1910f4ec791eff82b5", 13:00:08 INFO - "stage_platform": "linux64-pgo", 13:00:08 INFO - "builduid": "a8303e4d660347958e476d1f2509d06e", 13:00:08 INFO - "slavebuilddir": "test" 13:00:08 INFO - } 13:00:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:00:08 INFO - Running post-action listener: _resource_record_post_action 13:00:08 INFO - ##### 13:00:08 INFO - ##### Running download-and-extract step. 13:00:08 INFO - ##### 13:00:08 INFO - Running pre-action listener: _resource_record_pre_action 13:00:08 INFO - Running main action method: download_and_extract 13:00:08 INFO - mkdir: /builds/slave/test-pgo/build/tests 13:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:08 INFO - https://queue.taskcluster.net/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:00:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/test_packages.json 13:00:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/test_packages.json 13:00:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 13:00:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 13:00:08 INFO - Downloaded 1448 bytes. 13:00:08 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 13:00:08 INFO - Using the following test package requirements: 13:00:08 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:00:08 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:08 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:00:08 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:08 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:00:08 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:08 INFO - u'jsshell-linux-x86_64.zip'], 13:00:08 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:08 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:00:08 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:00:08 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:08 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:00:08 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:08 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:00:08 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:08 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:00:08 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:00:08 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:00:08 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:00:08 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:00:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:08 INFO - https://queue.taskcluster.net/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:00:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:00:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:00:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:00:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:00:09 INFO - Downloaded 22499424 bytes. 13:00:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:00:09 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 13:00:11 INFO - Return code: 0 13:00:11 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:00:11 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')]} 13:00:11 INFO - https://queue.taskcluster.net/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:00:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:00:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:00:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:00:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:00:12 INFO - Downloaded 22499424 bytes. 13:00:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:00:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 13:00:13 INFO - Return code: 0 13:00:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:13 INFO - https://queue.taskcluster.net/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:00:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:00:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:00:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:00:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:00:14 INFO - Downloaded 10706572 bytes. 13:00:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 13:00:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 13:00:14 INFO - Return code: 0 13:00: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')]} 13:00:14 INFO - https://queue.taskcluster.net/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:00:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:00:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:00:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:00:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:00:16 INFO - Downloaded 55972217 bytes. 13:00:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:00:16 INFO - mkdir: /builds/slave/test-pgo/properties 13:00:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 13:00:16 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 13:00:16 INFO - Contents: 13:00:16 INFO - build_url:https://queue.taskcluster.net/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:00:16 INFO - Running post-action listener: _resource_record_post_action 13:00:16 INFO - Running post-action listener: set_extra_try_arguments 13:00:16 INFO - ##### 13:00:16 INFO - ##### Running populate-webroot step. 13:00:16 INFO - ##### 13:00:16 INFO - Running pre-action listener: _resource_record_pre_action 13:00:16 INFO - Running main action method: populate_webroot 13:00:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:00:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:00:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:00:16 INFO - '--tppagecycles', 13:00:16 INFO - '7'], 13:00:16 INFO - 'tests': ['tsvgm']}}, 13:00:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:00:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:00:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:00:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:00:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:00:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:00:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:00:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:16 INFO - 'talos_options': ['--e10s'], 13:00:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:00:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:16 INFO - 'tests': ['damp', 'tps']}, 13:00:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:16 INFO - 'talos_options': ['--e10s'], 13:00:16 INFO - 'tests': ['damp', 'tps']}, 13:00:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:00:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:00:16 INFO - 'other': {'tests': ['a11yr', 13:00:16 INFO - 'ts_paint', 13:00:16 INFO - 'tpaint', 13:00:16 INFO - 'sessionrestore', 13:00:16 INFO - 'sessionrestore_no_auto_restore']}, 13:00:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:00:16 INFO - 'tests': ['a11yr', 13:00:16 INFO - 'ts_paint', 13:00:16 INFO - 'tpaint', 13:00:16 INFO - 'sessionrestore', 13:00:16 INFO - 'sessionrestore_no_auto_restore']}, 13:00:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:00:16 INFO - 'tests': ['a11yr', 13:00:16 INFO - 'ts_paint', 13:00:16 INFO - 'tpaint', 13:00:16 INFO - 'sessionrestore', 13:00:16 INFO - 'sessionrestore_no_auto_restore']}, 13:00:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:00:16 INFO - 'tests': ['a11yr', 13:00:16 INFO - 'ts_paint', 13:00:16 INFO - 'tpaint', 13:00:16 INFO - 'sessionrestore', 13:00:16 INFO - 'sessionrestore_no_auto_restore']}, 13:00:16 INFO - 'other_l64': {'tests': ['a11yr', 13:00:16 INFO - 'ts_paint', 13:00:16 INFO - 'tpaint', 13:00:16 INFO - 'sessionrestore', 13:00:16 INFO - 'sessionrestore_no_auto_restore']}, 13:00:16 INFO - 'other_nol64': {'tests': ['a11yr', 13:00:16 INFO - 'ts_paint', 13:00:16 INFO - 'tpaint', 13:00:16 INFO - 'sessionrestore', 13:00:16 INFO - 'sessionrestore_no_auto_restore']}, 13:00:16 INFO - 'svgr': {'tests': ['tsvgx', 13:00:16 INFO - 'tsvgr_opacity', 13:00:16 INFO - 'tart', 13:00:16 INFO - 'tscrollx', 13:00:16 INFO - 'cart']}, 13:00:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:00:16 INFO - 'tests': ['tsvgx', 13:00:16 INFO - 'tsvgr_opacity', 13:00:16 INFO - 'tart', 13:00:16 INFO - 'tscrollx', 13:00:16 INFO - 'cart']}, 13:00:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:16 INFO - 'tests': ['tp5o']}, 13:00:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:16 INFO - 'talos_options': ['--e10s'], 13:00:16 INFO - 'tests': ['tp5o']}, 13:00:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:16 INFO - 'talos_options': ['--xperf_path', 13:00:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:00:16 INFO - 'tests': ['tp5n']}, 13:00:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:00:16 INFO - 'talos_options': ['--e10s', 13:00:16 INFO - '--xperf_path', 13:00:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:00:16 INFO - 'tests': ['tp5n']}}, 13:00:16 INFO - 'talos.zip': {'path': '', 13:00:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:00:16 INFO - Running post-action listener: _resource_record_post_action 13:00:16 INFO - ##### 13:00:16 INFO - ##### Running create-virtualenv step. 13:00:16 INFO - ##### 13:00:16 INFO - Running pre-action listener: _resource_record_pre_action 13:00:16 INFO - Running main action method: create_virtualenv 13:00:16 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 13:00:16 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 13:00:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 13:00:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:00:16 INFO - Using real prefix '/usr' 13:00:16 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 13:00:16 INFO - Installing distribute.............................................................................................................................................................................................done. 13:00:18 INFO - Installing pip.................done. 13:00:18 INFO - Return code: 0 13:00:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 13:00: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')]} 13:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00: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')]} 13:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:18 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb47b007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9660>, '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 0x13aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aaa10>, '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': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', '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 13:00:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 13:00:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:00:18 INFO - Using env: {'DISPLAY': ':0', 13:00:18 INFO - 'HOME': '/home/cltbld', 13:00:18 INFO - 'LANG': 'en_US.UTF-8', 13:00:18 INFO - 'LANGUAGE': 'en_US:en', 13:00:18 INFO - 'LOGNAME': 'cltbld', 13:00:18 INFO - 'MAIL': '/var/mail/cltbld', 13:00:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:18 INFO - 'MOZ_NO_REMOTE': '1', 13:00:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:18 INFO - 'NO_EM_RESTART': '1', 13:00:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:00:18 INFO - 'PWD': '/builds/slave/test-pgo', 13:00:18 INFO - 'SHELL': '/bin/bash', 13:00:18 INFO - 'SHLVL': '1', 13:00:18 INFO - 'TERM': 'linux', 13:00:18 INFO - 'TMOUT': '86400', 13:00:18 INFO - 'USER': 'cltbld', 13:00:18 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', 13:00:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:18 INFO - '_': '/tools/buildbot/bin/python'} 13:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:19 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 13:00:19 INFO - Cleaning up... 13:00:19 INFO - Return code: 0 13:00:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 13:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb47b007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9660>, '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 0x13aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aaa10>, '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': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', '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 13:00:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 13:00:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 13:00:19 INFO - Using env: {'DISPLAY': ':0', 13:00:19 INFO - 'HOME': '/home/cltbld', 13:00:19 INFO - 'LANG': 'en_US.UTF-8', 13:00:19 INFO - 'LANGUAGE': 'en_US:en', 13:00:19 INFO - 'LOGNAME': 'cltbld', 13:00:19 INFO - 'MAIL': '/var/mail/cltbld', 13:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:19 INFO - 'MOZ_NO_REMOTE': '1', 13:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:19 INFO - 'NO_EM_RESTART': '1', 13:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:00:19 INFO - 'PWD': '/builds/slave/test-pgo', 13:00:19 INFO - 'SHELL': '/bin/bash', 13:00:19 INFO - 'SHLVL': '1', 13:00:19 INFO - 'TERM': 'linux', 13:00:19 INFO - 'TMOUT': '86400', 13:00:19 INFO - 'USER': 'cltbld', 13:00:19 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', 13:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:19 INFO - '_': '/tools/buildbot/bin/python'} 13:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:19 INFO - Downloading/unpacking psutil>=0.7.1 13:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 13:00:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:00:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:00:21 INFO - Installing collected packages: psutil 13:00:21 INFO - Running setup.py install for psutil 13:00:21 INFO - building 'psutil._psutil_linux' extension 13:00:21 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 13:00:21 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 13:00:21 INFO - building 'psutil._psutil_posix' extension 13:00:21 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 13:00:21 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 13:00:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:00:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:00:21 INFO - Successfully installed psutil 13:00:21 INFO - Cleaning up... 13:00:21 INFO - Return code: 0 13:00:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 13:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:21 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb47b007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9660>, '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 0x13aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aaa10>, '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': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', '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 13:00:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 13:00:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:00:21 INFO - Using env: {'DISPLAY': ':0', 13:00:21 INFO - 'HOME': '/home/cltbld', 13:00:21 INFO - 'LANG': 'en_US.UTF-8', 13:00:21 INFO - 'LANGUAGE': 'en_US:en', 13:00:21 INFO - 'LOGNAME': 'cltbld', 13:00:21 INFO - 'MAIL': '/var/mail/cltbld', 13:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:21 INFO - 'MOZ_NO_REMOTE': '1', 13:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:21 INFO - 'NO_EM_RESTART': '1', 13:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:00:21 INFO - 'PWD': '/builds/slave/test-pgo', 13:00:21 INFO - 'SHELL': '/bin/bash', 13:00:21 INFO - 'SHLVL': '1', 13:00:21 INFO - 'TERM': 'linux', 13:00:21 INFO - 'TMOUT': '86400', 13:00:21 INFO - 'USER': 'cltbld', 13:00:21 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', 13:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:21 INFO - '_': '/tools/buildbot/bin/python'} 13:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:00:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:00:23 INFO - Installing collected packages: mozsystemmonitor 13:00:23 INFO - Running setup.py install for mozsystemmonitor 13:00:23 INFO - Successfully installed mozsystemmonitor 13:00:23 INFO - Cleaning up... 13:00:23 INFO - Return code: 0 13:00:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 13:00: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')]} 13:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00: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')]} 13:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:23 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb47b007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9660>, '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 0x13aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aaa10>, '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': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', '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 13:00:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 13:00:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:00:23 INFO - Using env: {'DISPLAY': ':0', 13:00:23 INFO - 'HOME': '/home/cltbld', 13:00:23 INFO - 'LANG': 'en_US.UTF-8', 13:00:23 INFO - 'LANGUAGE': 'en_US:en', 13:00:23 INFO - 'LOGNAME': 'cltbld', 13:00:23 INFO - 'MAIL': '/var/mail/cltbld', 13:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:23 INFO - 'MOZ_NO_REMOTE': '1', 13:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:23 INFO - 'NO_EM_RESTART': '1', 13:00:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:00:23 INFO - 'PWD': '/builds/slave/test-pgo', 13:00:23 INFO - 'SHELL': '/bin/bash', 13:00:23 INFO - 'SHLVL': '1', 13:00:23 INFO - 'TERM': 'linux', 13:00:23 INFO - 'TMOUT': '86400', 13:00:23 INFO - 'USER': 'cltbld', 13:00:23 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', 13:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:23 INFO - '_': '/tools/buildbot/bin/python'} 13:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:24 INFO - Downloading/unpacking blobuploader==1.2.4 13:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:25 INFO - Downloading blobuploader-1.2.4.tar.gz 13:00:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:00:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 13:00:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:00:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:00:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:00:26 INFO - Downloading docopt-0.6.1.tar.gz 13:00:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 13:00:26 INFO - Installing collected packages: blobuploader, requests, docopt 13:00:26 INFO - Running setup.py install for blobuploader 13:00:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:00:26 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 13:00:26 INFO - Running setup.py install for requests 13:00:27 INFO - Running setup.py install for docopt 13:00:27 INFO - Successfully installed blobuploader requests docopt 13:00:27 INFO - Cleaning up... 13:00:27 INFO - Return code: 0 13:00:27 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:00: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')]} 13:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00: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')]} 13:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:27 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 0x7fb47b007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9660>, '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 0x13aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aaa10>, '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': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', '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 13:00:27 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 13:00:27 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 13:00:27 INFO - Using env: {'DISPLAY': ':0', 13:00:27 INFO - 'HOME': '/home/cltbld', 13:00:27 INFO - 'LANG': 'en_US.UTF-8', 13:00:27 INFO - 'LANGUAGE': 'en_US:en', 13:00:27 INFO - 'LOGNAME': 'cltbld', 13:00:27 INFO - 'MAIL': '/var/mail/cltbld', 13:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:27 INFO - 'MOZ_NO_REMOTE': '1', 13:00:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:27 INFO - 'NO_EM_RESTART': '1', 13:00:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:00:27 INFO - 'PWD': '/builds/slave/test-pgo', 13:00:27 INFO - 'SHELL': '/bin/bash', 13:00:27 INFO - 'SHLVL': '1', 13:00:27 INFO - 'TERM': 'linux', 13:00:27 INFO - 'TMOUT': '86400', 13:00:27 INFO - 'USER': 'cltbld', 13:00:27 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', 13:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:27 INFO - '_': '/tools/buildbot/bin/python'} 13:00:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:00:27 INFO - Running setup.py (path:/tmp/pip-zxMmjB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:00:27 INFO - Running setup.py (path:/tmp/pip-5Qg0b0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:00:27 INFO - Running setup.py (path:/tmp/pip-VY7rff-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:00:27 INFO - Running setup.py (path:/tmp/pip-bZUNXp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:00:27 INFO - Running setup.py (path:/tmp/pip-iWLuFO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:00:27 INFO - Running setup.py (path:/tmp/pip-227nCw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:00:27 INFO - Running setup.py (path:/tmp/pip-z6EMO3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:00:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:00:27 INFO - Running setup.py (path:/tmp/pip-fkM_Q1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:00:28 INFO - Running setup.py (path:/tmp/pip-39zroB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:00:28 INFO - Running setup.py (path:/tmp/pip-5ftE5l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:00:28 INFO - Running setup.py (path:/tmp/pip-yVEGfJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:00:28 INFO - Running setup.py (path:/tmp/pip-3g0bxK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:00:28 INFO - Running setup.py (path:/tmp/pip-tgcNq2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:00:28 INFO - Running setup.py (path:/tmp/pip-paX1Ny-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:00:28 INFO - Running setup.py (path:/tmp/pip-n4PjXe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:00:28 INFO - Running setup.py (path:/tmp/pip-afGaDA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:00:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:00:28 INFO - Running setup.py (path:/tmp/pip-SkjxMZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:00:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:00:28 INFO - Running setup.py install for manifestparser 13:00:28 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 13:00:28 INFO - Running setup.py install for mozcrash 13:00:28 INFO - Running setup.py install for mozdebug 13:00:28 INFO - Running setup.py install for mozdevice 13:00:29 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 13:00:29 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 13:00:29 INFO - Running setup.py install for mozfile 13:00:29 INFO - Running setup.py install for mozhttpd 13:00:29 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 13:00:29 INFO - Running setup.py install for mozinfo 13:00:29 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 13:00:29 INFO - Running setup.py install for mozInstall 13:00:29 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 13:00:29 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 13:00:29 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 13:00:29 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 13:00:29 INFO - Running setup.py install for mozleak 13:00:29 INFO - Running setup.py install for mozlog 13:00:29 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 13:00:29 INFO - Running setup.py install for moznetwork 13:00:29 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 13:00:29 INFO - Running setup.py install for mozprocess 13:00:29 INFO - Running setup.py install for mozprofile 13:00:30 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 13:00:30 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 13:00:30 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 13:00:30 INFO - Running setup.py install for mozrunner 13:00:30 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 13:00:30 INFO - Running setup.py install for mozscreenshot 13:00:30 INFO - Running setup.py install for moztest 13:00:30 INFO - Running setup.py install for mozversion 13:00:30 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 13:00:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:00:30 INFO - Cleaning up... 13:00:30 INFO - Return code: 0 13:00:30 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:00:30 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')]} 13:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:30 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')]} 13:00:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:30 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 0x7fb47b007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9660>, '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 0x13aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aaa10>, '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': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', '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 13:00:30 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 13:00:30 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 13:00:30 INFO - Using env: {'DISPLAY': ':0', 13:00:30 INFO - 'HOME': '/home/cltbld', 13:00:30 INFO - 'LANG': 'en_US.UTF-8', 13:00:30 INFO - 'LANGUAGE': 'en_US:en', 13:00:30 INFO - 'LOGNAME': 'cltbld', 13:00:30 INFO - 'MAIL': '/var/mail/cltbld', 13:00:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:30 INFO - 'MOZ_NO_REMOTE': '1', 13:00:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:30 INFO - 'NO_EM_RESTART': '1', 13:00:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:00:30 INFO - 'PWD': '/builds/slave/test-pgo', 13:00:30 INFO - 'SHELL': '/bin/bash', 13:00:30 INFO - 'SHLVL': '1', 13:00:30 INFO - 'TERM': 'linux', 13:00:30 INFO - 'TMOUT': '86400', 13:00:30 INFO - 'USER': 'cltbld', 13:00:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', 13:00:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:30 INFO - '_': '/tools/buildbot/bin/python'} 13:00:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:00:30 INFO - Running setup.py (path:/tmp/pip-BV2jR7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 13:00:30 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)) 13:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:00:30 INFO - Running setup.py (path:/tmp/pip-R9LGY8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 13:00:30 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)) 13:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:00:30 INFO - Running setup.py (path:/tmp/pip-nsS7tP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 13:00:30 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)) 13:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:00:30 INFO - Running setup.py (path:/tmp/pip-qFmN9G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 13:00:30 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)) 13:00:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 13:00:30 INFO - Running setup.py (path:/tmp/pip-1rFKQb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 13:00:31 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)) 13:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:00:31 INFO - Running setup.py (path:/tmp/pip-DttLEt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 13:00:31 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)) 13:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:00:31 INFO - Running setup.py (path:/tmp/pip-UA_vMe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 13:00:31 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)) 13:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:00:31 INFO - Running setup.py (path:/tmp/pip-wpi7i_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 13:00:31 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)) 13:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 13:00:31 INFO - Running setup.py (path:/tmp/pip-qd6ij1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 13:00:31 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)) 13:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 13:00:31 INFO - Running setup.py (path:/tmp/pip-9kn7QX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 13:00:31 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)) 13:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:00:31 INFO - Running setup.py (path:/tmp/pip-0Zlwn6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 13:00:31 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)) 13:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:00:31 INFO - Running setup.py (path:/tmp/pip-NxmYr0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 13:00:31 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)) 13:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:00:31 INFO - Running setup.py (path:/tmp/pip-9VkAEI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 13:00:31 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)) 13:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:00:31 INFO - Running setup.py (path:/tmp/pip-Bu7qCx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 13:00:31 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)) 13:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:00:31 INFO - Running setup.py (path:/tmp/pip-vzUXnj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 13:00:31 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)) 13:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 13:00:31 INFO - Running setup.py (path:/tmp/pip-faQgBt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 13:00:31 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)) 13:00:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 13:00:31 INFO - Running setup.py (path:/tmp/pip-pVZMXp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 13:00:31 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)) 13:00:31 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)) 13:00:31 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)) 13:00:31 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)) 13:00:31 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)) 13:00:31 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)) 13:00:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 13:00:31 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 13:00:31 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 13:00:31 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 13:00:31 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 13:00:31 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 13:00:31 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 13:00:33 INFO - Downloading blessings-1.6.tar.gz 13:00:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 13:00:33 INFO - Installing collected packages: blessings 13:00:33 INFO - Running setup.py install for blessings 13:00:33 INFO - Successfully installed blessings 13:00:33 INFO - Cleaning up... 13:00:33 INFO - Return code: 0 13:00:33 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 13:00:33 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:00:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:00:34 INFO - Reading from file tmpfile_stdout 13:00:34 INFO - Current package versions: 13:00:34 INFO - argparse == 1.2.1 13:00:34 INFO - blessings == 1.6 13:00:34 INFO - blobuploader == 1.2.4 13:00:34 INFO - docopt == 0.6.1 13:00:34 INFO - manifestparser == 1.1 13:00:34 INFO - mozInstall == 1.12 13:00:34 INFO - mozcrash == 0.16 13:00:34 INFO - mozdebug == 0.1 13:00:34 INFO - mozdevice == 0.48 13:00:34 INFO - mozfile == 1.2 13:00:34 INFO - mozhttpd == 0.7 13:00:34 INFO - mozinfo == 0.9 13:00:34 INFO - mozleak == 0.1 13:00:34 INFO - mozlog == 3.1 13:00:34 INFO - moznetwork == 0.27 13:00:34 INFO - mozprocess == 0.22 13:00:34 INFO - mozprofile == 0.28 13:00:34 INFO - mozrunner == 6.11 13:00:34 INFO - mozscreenshot == 0.1 13:00:34 INFO - mozsystemmonitor == 0.0 13:00:34 INFO - moztest == 0.7 13:00:34 INFO - mozversion == 1.4 13:00:34 INFO - psutil == 3.1.1 13:00:34 INFO - requests == 1.2.3 13:00:34 INFO - wsgiref == 0.1.2 13:00:34 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 13:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:34 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 0x7fb47b007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9660>, '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 0x13aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aaa10>, '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': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', '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 13:00:34 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 13:00:34 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 13:00:34 INFO - Using env: {'DISPLAY': ':0', 13:00:34 INFO - 'HOME': '/home/cltbld', 13:00:34 INFO - 'LANG': 'en_US.UTF-8', 13:00:34 INFO - 'LANGUAGE': 'en_US:en', 13:00:34 INFO - 'LOGNAME': 'cltbld', 13:00:34 INFO - 'MAIL': '/var/mail/cltbld', 13:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:34 INFO - 'MOZ_NO_REMOTE': '1', 13:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:34 INFO - 'NO_EM_RESTART': '1', 13:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:00:34 INFO - 'PWD': '/builds/slave/test-pgo', 13:00:34 INFO - 'SHELL': '/bin/bash', 13:00:34 INFO - 'SHLVL': '1', 13:00:34 INFO - 'TERM': 'linux', 13:00:34 INFO - 'TMOUT': '86400', 13:00:34 INFO - 'USER': 'cltbld', 13:00:34 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', 13:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:34 INFO - '_': '/tools/buildbot/bin/python'} 13:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:34 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)) 13:00:34 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)) 13:00:34 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)) 13:00:34 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)) 13:00:34 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)) 13:00:34 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)) 13:00:34 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)) 13:00:34 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)) 13:00:34 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)) 13:00:34 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)) 13:00:34 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)) 13:00:34 INFO - Cleaning up... 13:00:34 INFO - Return code: 0 13:00:34 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 13:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:34 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 0x7fb47b007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9660>, '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 0x13aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aaa10>, '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': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', '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 13:00:34 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 13:00:34 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 13:00:34 INFO - Using env: {'DISPLAY': ':0', 13:00:34 INFO - 'HOME': '/home/cltbld', 13:00:34 INFO - 'LANG': 'en_US.UTF-8', 13:00:34 INFO - 'LANGUAGE': 'en_US:en', 13:00:34 INFO - 'LOGNAME': 'cltbld', 13:00:34 INFO - 'MAIL': '/var/mail/cltbld', 13:00:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:34 INFO - 'MOZ_NO_REMOTE': '1', 13:00:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:34 INFO - 'NO_EM_RESTART': '1', 13:00:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:00:34 INFO - 'PWD': '/builds/slave/test-pgo', 13:00:34 INFO - 'SHELL': '/bin/bash', 13:00:34 INFO - 'SHLVL': '1', 13:00:34 INFO - 'TERM': 'linux', 13:00:34 INFO - 'TMOUT': '86400', 13:00:34 INFO - 'USER': 'cltbld', 13:00:34 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', 13:00:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:34 INFO - '_': '/tools/buildbot/bin/python'} 13:00:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:34 INFO - Downloading/unpacking jsonschema 13:00: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 13:00: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 13:00: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 13:00: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 13:00: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 13:00: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 13:00:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:00:36 INFO - Downloading/unpacking functools32 (from jsonschema) 13:00:36 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 13:00:36 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 13:00:36 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 13:00:36 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 13:00:36 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 13:00:36 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 13:00:36 INFO - Downloading functools32-3.2.3-2.tar.gz 13:00:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 13:00:36 INFO - warning: no files found matching '*.txt' 13:00:36 INFO - no previously-included directories found matching 'build' 13:00:36 INFO - no previously-included directories found matching 'dist' 13:00:36 INFO - no previously-included directories found matching '.git*' 13:00:36 INFO - Installing collected packages: jsonschema, functools32 13:00:36 INFO - Running setup.py install for functools32 13:00:36 INFO - warning: no files found matching '*.txt' 13:00:36 INFO - no previously-included directories found matching 'build' 13:00:36 INFO - no previously-included directories found matching 'dist' 13:00:36 INFO - no previously-included directories found matching '.git*' 13:00:36 INFO - Successfully installed jsonschema functools32 13:00:36 INFO - Cleaning up... 13:00:36 INFO - Return code: 0 13:00:36 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 13:00:36 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')]} 13:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:36 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')]} 13:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:00:36 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 0x7fb47b007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x124d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x131a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13a9660>, '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 0x13aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aaa10>, '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': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', '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 13:00:36 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 13:00:36 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 13:00:36 INFO - Using env: {'DISPLAY': ':0', 13:00:36 INFO - 'HOME': '/home/cltbld', 13:00:36 INFO - 'LANG': 'en_US.UTF-8', 13:00:36 INFO - 'LANGUAGE': 'en_US:en', 13:00:36 INFO - 'LOGNAME': 'cltbld', 13:00:36 INFO - 'MAIL': '/var/mail/cltbld', 13:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:36 INFO - 'MOZ_NO_REMOTE': '1', 13:00:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:36 INFO - 'NO_EM_RESTART': '1', 13:00:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:00:36 INFO - 'PWD': '/builds/slave/test-pgo', 13:00:36 INFO - 'SHELL': '/bin/bash', 13:00:36 INFO - 'SHLVL': '1', 13:00:36 INFO - 'TERM': 'linux', 13:00:36 INFO - 'TMOUT': '86400', 13:00:36 INFO - 'USER': 'cltbld', 13:00:36 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', 13:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:36 INFO - '_': '/tools/buildbot/bin/python'} 13:00:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:00:37 INFO - Downloading/unpacking flake8 13:00:37 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 13:00:37 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 13:00:37 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 13:00:37 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 13:00:37 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 13:00:37 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 13:00:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:00:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:00:38 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 13:00:38 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 13:00:38 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 13:00:38 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 13:00:38 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 13:00:38 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 13:00:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:00:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:00:38 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 13:00:38 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 13:00:38 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 13:00:38 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 13:00:38 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 13:00:38 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 13:00:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:00:39 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 13:00:39 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 13:00:39 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 13:00:39 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 13:00:39 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 13:00:39 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 13:00:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 13:00:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:00:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:00:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:00:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:00:39 INFO - no previously-included directories found matching 'docs/_build' 13:00:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:00:39 INFO - Running setup.py install for pep8 13:00:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:00:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:00:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:00:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:00:39 INFO - no previously-included directories found matching 'docs/_build' 13:00:39 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 13:00:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:00:39 INFO - Cleaning up... 13:00:39 INFO - Return code: 0 13:00:39 INFO - Running post-action listener: _resource_record_post_action 13:00:39 INFO - Running post-action listener: _start_resource_monitoring 13:00:39 INFO - Starting resource monitoring. 13:00:39 INFO - ##### 13:00:39 INFO - ##### Running install step. 13:00:39 INFO - ##### 13:00:39 INFO - Running pre-action listener: _resource_record_pre_action 13:00:39 INFO - Running main action method: install 13:00:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 13:00:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 13:00:39 INFO - Reading from file tmpfile_stdout 13:00:39 INFO - Detecting whether we're running mozinstall >=1.0... 13:00:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 13:00:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 13:00:40 INFO - Reading from file tmpfile_stdout 13:00:40 INFO - Output received: 13:00:40 INFO - Usage: mozinstall [options] installer 13:00:40 INFO - Options: 13:00:40 INFO - -h, --help show this help message and exit 13:00:40 INFO - -d DEST, --destination=DEST 13:00:40 INFO - Directory to install application into. [default: 13:00:40 INFO - "/builds/slave/test-pgo"] 13:00:40 INFO - --app=APP Application being installed. [default: firefox] 13:00:40 INFO - mkdir: /builds/slave/test-pgo/build/application 13:00:40 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 13:00:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 13:00:56 INFO - Reading from file tmpfile_stdout 13:00:56 INFO - Output received: 13:00:56 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 13:00:56 INFO - Running post-action listener: _resource_record_post_action 13:00:56 INFO - ##### 13:00:56 INFO - ##### Running run-tests step. 13:00:56 INFO - ##### 13:00:56 INFO - Running pre-action listener: _resource_record_pre_action 13:00:56 INFO - Running main action method: run_tests 13:00:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 13:00:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 13:00:56 INFO - Python 2.7.3 13:00:56 INFO - Return code: 0 13:00:56 INFO - grabbing minidump binary from tooltool 13:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:00:56 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 0x13a9660>, '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 0x13aa560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13aaa10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 13:00:56 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 13:00:56 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 13:00:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:00:56 INFO - Return code: 0 13:00:56 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 13:00:56 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 13:00:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 13:00:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 13:00:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 13:00:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 13:00:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 13:00:57 INFO - Return code: 0 13:00:57 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/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 13:00:57 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/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 13:00:57 INFO - Using env: {'DISPLAY': ':0', 13:00:57 INFO - 'HOME': '/home/cltbld', 13:00:57 INFO - 'LANG': 'en_US.UTF-8', 13:00:57 INFO - 'LANGUAGE': 'en_US:en', 13:00:57 INFO - 'LOGNAME': 'cltbld', 13:00:57 INFO - 'MAIL': '/var/mail/cltbld', 13:00:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:00:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 13:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:00:57 INFO - 'MOZ_NO_REMOTE': '1', 13:00:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 13:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:00:57 INFO - 'NO_EM_RESTART': '1', 13:00:57 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 13:00:57 INFO - 'PWD': '/builds/slave/test-pgo', 13:00:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 13:00:57 INFO - 'SHELL': '/bin/bash', 13:00:57 INFO - 'SHLVL': '1', 13:00:57 INFO - 'TERM': 'linux', 13:00:57 INFO - 'TMOUT': '86400', 13:00:57 INFO - 'USER': 'cltbld', 13:00:57 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410', 13:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:00:57 INFO - '_': '/tools/buildbot/bin/python'} 13:00:57 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/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 13:00:57 INFO - mozversion application_buildid: 20160125103134 13:00:57 INFO - mozversion application_changeset: 1b7625c90538a95413f7ca1910f4ec791eff82b5 13:00:57 INFO - mozversion application_display_name: Nightly 13:00:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:00:57 INFO - mozversion application_name: Firefox 13:00:57 INFO - mozversion application_remotingname: firefox 13:00:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:00:57 INFO - mozversion application_vendor: Mozilla 13:00:57 INFO - mozversion application_version: 46.0a1 13:00:57 INFO - mozversion platform_buildid: 20160125103134 13:00:57 INFO - mozversion platform_changeset: 1b7625c90538a95413f7ca1910f4ec791eff82b5 13:00:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 13:00:57 INFO - mozversion platform_version: 46.0a1 13:00:57 INFO - using testdate: 1453755657 13:00:57 INFO - actual date: 1453755657 13:00:57 INFO - starting webserver on 'localhost:38710' 13:00:57 INFO - SUITE-START | Running 3 tests 13:00:57 INFO - TEST-START | dromaeo_css 13:00:57 INFO - operating with platform_type : linux_ 13:00:57 INFO - Initialising browser for dromaeo_css test... 13:00:57 INFO - TEST-INFO | started process 15707 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpq6vblV/profile http://localhost:38710/getInfo.html) 13:01:00 INFO - PROCESS | 15707 | 13:01:00 INFO - PROCESS | 15707 | (process:15789): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:01:01 INFO - PROCESS | 15707 | __metrics Screen width/height:1600/1200 13:01:01 INFO - PROCESS | 15707 | colorDepth:24 13:01:01 INFO - PROCESS | 15707 | Browser inner width/height: 1024/697 13:01:01 INFO - PROCESS | 15707 | __metrics 13:01:01 INFO - PROCESS | 15707 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:01:02 INFO - TEST-INFO | 15707: exit 0 13:01:02 INFO - Browser initialized. 13:01:02 INFO - Running cycle 1/1 for dromaeo_css test... 13:01:02 INFO - TEST-INFO | started process 15838 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpq6vblV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:01:03 INFO - PROCESS | 15838 | 13:01:03 INFO - PROCESS | 15838 | (process:15900): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:01:14 INFO - PROCESS | 15838 | RSS: Main: 150953984 13:01:14 INFO - PROCESS | 15838 | 13:02:03 INFO - PROCESS | 15838 | 1453755723975 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 13:04:13 INFO - PROCESS | 15838 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38710/tests/dromaeo/cssquery-ext.html) 13:04:14 INFO - PROCESS | 15838 | RSS: Main: 158941184 13:04:14 INFO - PROCESS | 15838 | 13:07:16 INFO - PROCESS | 15838 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-ext.html (next: http://localhost:38710/tests/dromaeo/cssquery-jquery.html) 13:07:16 INFO - PROCESS | 15838 | RSS: Main: 155336704 13:07:16 INFO - PROCESS | 15838 | 13:10:18 INFO - PROCESS | 15838 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38710/tests/dromaeo/cssquery-mootools.html) 13:10:19 INFO - PROCESS | 15838 | RSS: Main: 156008448 13:10:19 INFO - PROCESS | 15838 | 13:13:20 INFO - PROCESS | 15838 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38710/tests/dromaeo/cssquery-prototype.html) 13:13:21 INFO - PROCESS | 15838 | RSS: Main: 154112000 13:13:21 INFO - PROCESS | 15838 | 13:16:23 INFO - PROCESS | 15838 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38710/tests/dromaeo/cssquery-yui.html) 13:16:24 INFO - PROCESS | 15838 | RSS: Main: 155385856 13:16:24 INFO - PROCESS | 15838 | 13:19:26 INFO - PROCESS | 15838 | Cycle 1(1): loaded http://localhost:38710/tests/dromaeo/cssquery-yui.html (next: http://localhost:38710/tests/dromaeo/cssquery-dojo.html) 13:19:27 INFO - PROCESS | 15838 | RSS: Main: 157990912 13:19:27 INFO - PROCESS | 15838 | 13:19:27 INFO - PROCESS | 15838 | __start_tp_report 13:19:27 INFO - PROCESS | 15838 | _x_x_mozilla_page_load 13:19:27 INFO - PROCESS | 15838 | _x_x_mozilla_page_load_details 13:19:27 INFO - PROCESS | 15838 | |i|pagename|runs| 13:19:27 INFO - PROCESS | 15838 | |0;dojo.html;3186.060112266881;3235.6440791512914;3255.9348813023726;3277.0660361796877;3286.2770190558085;5237.319148510688;5255.789768409259;5298.788048478056;5342.759575819093;5352.598555108368;5250.8687282817855;5290.576753859692;5319.867003324919;5321.414644389114;5337.919931201035;4848.927266091003;4917.4099108107075;5005.899882002358;5035.144025515653;5076.974615126937;4944.703317800943;5005.374328208974;5017.64876458648;5023.372078490189;5061.114304996611;4826.107170173529;4952.4057113146655;4968.279599458095;4969.229769385751;5017.071841709296;4848.587870031051;4902.975485122587;4956.281339205831;4960.454350021495;4994.775235114393;4861.118017363983;4866.124097662419;4873.585745211662;4877.0489754497885;4879.731614761186;5156.664816786934;5183.403908550527;5187.8184263550975;5208.401033881114;5299.205119232108;5638.915416268759;5674.659520428746;5687.7156142192725;5695.686737229451;5699.57253206007;5819.301683797929;5837;5851.970740146272;5909.7636094556165;5910.704464776787;5436.401995780461;5444.047291723932;5462.617616766828;5465.453454654503;5468.2891224141;5816.069428891442;5913.763449461973;5928.436798504135;5943.970280148658;5983.6708981005595;5742.339630942495;5757.971210143923;5763.6541807491685;5764.510016648548;5781.8554536136935;5766.250387449605;5789.478946894799;5836.766529338779;5840.795572154954;5847.152162936351;5672.744726487318;5680.5455563554815;5774.566907481955;5802;5803.622764520293;5788.623739456922;5807.303123625107;5835.533157347402;5840.065589505659;5852.034414321674;4422;4427.645788336926;4446.510883802779;4455.509893911667;4466.196084704784;3934.626210510054;3950.6839452843706;3977.105151340925;4008.098177909947;4038.9498730330324;5299;5329.626926115212;5348.786048558092;5372.409035006146;5404.83785486436;5640.633358831663;5720.256366672306;5726.055200891807;5728.112142617901;5733.684647344436;5105.15764898795;5130.820421285312;5133.512316329943;5136.203888397305;5170.922436163461;4663.860084197479;4701.412323459567;4712.175369310357;4741.502142275081;4892.217245240744;5923.4076592340425;5983.940160598426;5990.281166260077;6001.36985616504;6010.158577799111;5713.628614140068;5750.942490575125;5756.769729210785;5758.395368486249;5764.048931926185;5793.884122317614;5818.709064546841;5893.116032595145;5900.409959004237;5952.940470595238;5589.413111623384;5594.748236329294;5604.607677462538;5608.523275521627;5776.797812076557;5866.765329386777;5877.823665289877;5879.353271140086;5883.499902508334;5897.410258974069;5672.4894759471845;5702.857428564319;5706.572007099401;5748.166515855261;5761.020626493422;5603.719814009365;5611.214429979725;5668.093105103164;5671.631343962629;5714.542836573148;5496.7526461308535;5539.695316757456;5544.22380866687;5546.112621980464;5558.777648893999;5626.35296940857;5643.435656434323;5666.829995100154;5678.3753787084215;5698.088305871206;5437.918431223456;5511.200875873056;5565.833025009256;5585.776568937197;5601.355844077983 13:19:27 INFO - PROCESS | 15838 | |1;ext.html;508.2401809295102;533.6557920141511;564.9745761440735;569.8347479231023;571.5427657873702;34916;35459.645403545954;35826;35842;35897.28205435893;38017.80991095048;38252;38657.613423865754;38713.612863871356;38720;8482.279006284472;8629.568521573896;8704.30365570756;8710.259627931633;8712.128787121268;8590.355723320745;8722.476651400904;8724.345674074439;8812.691555795549;8839.690610828622;8774.298056155525;8838.734837954871;8847.336449766293;8896.377253592218;8917.55412229386;8691.826163476726;8743.519106449143;8767.51778652177;8770.386072974894;8814.64741410346;8703.390762646553;8750.737477875611;8821.294296456268;8838.55807209637;8862.291016718647;38949.80525097385;39300.60699392998;39386.80306598449;39387.60612393868;39501.60498395037;2956.822590644568;3015.9187280906526;3039.559263906743;3247.561579186803;3402.268512269849;29102.417951640848;30290.24274393158;30305.242368940733;30703.385932281228;30766.69233307683;3933.6263055009726;3979.7214195006363;4066.430699702044;4133.0700592366475;4162.250794856925;248447;248733;249733;249771;250661;57700;57982;58100.70949645225;58497.415025850045;58585.41414585885;63237.68381158157;64539.35460645334;64595.677021615535;64693;64734.35265647378;13154.671133221555;13318.800217996737;13440.596782096552;13496.055276130774;13541.729165416833;9980.151687106532;10033.347832390871;10061.647842325483;10074.44590547527;10102.747431314276;19752.11115499806;19917.30289439863;19965.60068798616;20008.49978750543;20879.598846132587;8056.919430805734;8288.50268983863;8290;8308.750737477885;8332.958335208406;901.6258252825004;950.8954015058338;998.9500524973722;1002.7042022603204;1050.7898420315814;28489.43021139607;30392.848035759678;31282.843585781924;31296.687033129834;31589;975.1321324021626;992.9007099290158;1018.4856647393019;1065.248999455382;1096.555894862582;14470.421183152555;14517.128972261698;14646.707065858624;14786.112833229825;14875.925620372045;334765;338412.30793845875;339136;339272;339473;53308;54086;54124.188137177975;54230.45769542333;54269.45730542644;1272.5100836178137;1297.6820678933532;1322.9338533073308;1327.6481732340937;1346.1048402812216;28104.85947570249;28689.262147570986;28815.9729137627;29193.270168245963;29225.97709080257;45724.54275457203;46094;46381.304280436496;46441;46542.53457465382;292084;292220;292296;293593;293988;27498.17505474839;27833;30981.53527697041;31440.842795785873;32667;37362.2527549442;37689.62310376861;37747.245055098196;38510.80744596259;38575;34449;34476.82761586176;34504.13739656529;38542.33847784456;40113.99715007148;33750;37474.625253747115;38743.2251354977;39131.80434097811;39386.40920386139;33387.83306083454;33625.15937101494;33861.492077618364;33940.83029584836;34005.82997084999;29653.25866853346;32638.184045398106;32802.50796238106;33021.17447063843;33182;24619.63070553979;25506.74493255044;25543;25656.844172460384;25804.225873223833 13:19:27 INFO - PROCESS | 15838 | |2;jquery.html;360.624950051946;363.8490026638947;363.95996440391554;364.79571439993595;365.75677174678833;15423.383064677413;16510.504684859443;16682.91658541707;17163.455289023987;18028.188731507096;10473.947630261857;10540.104091152241;10804.459777011158;10810.35137891727;10833.079188269006;4795.2807078938085;4798.304245884345;4957.752112394384;5013.298138260647;5015.147424937751;4883.658143929926;4948.134076536592;4973.676711013791;4974.204127339626;4975.12935236334;3689.3912504436735;3810.2760475509704;4979;4995.850124496253;5489.149181876795;5116.104681680709;5280.07598670235;5297.576193904498;5298.36419629645;5308.0710875596615;4985.675931064469;5028.84913452597;5263.26314315996;5272.710000949946;5288.8413347599635;18251.543711407186;18307.908460457613;19178.904105479523;19984.100715467837;20027.6995845061;1999.1103958738368;2046.8055534724326;2053.5790163016545;2120.056574824204;2123.6177488052144;5405.135178371442;10706.250562460631;11202.719932001684;12674.112812103156;12819.102662813606;1736.6179440523065;1755.7278621813512;1830.0941034188163;1834.5688763140652;1898.686716691744;50319.24521132186;52473.47526524724;52725.20912186358;53211.467885321035;53276.73361633206;9634.566444510014;9730.659426920023;9920.80158396828;9951.054649808257;10009.649662261785;12962.351882405843;13044.54344097971;13044.934775326063;13057.281849498178;13061.542846000344;6887.104676392137;6979.685914133876;7166.104236970379;7214.855702885913;7229.987801707765;6529.477641788645;6540.411362977355;6570.8357291068105;6581.934180658132;6731.124953755981;4331.242032644274;4347.087111706577;4385.956140438555;4397.208502469586;4426.048399594103;1809.5204770735766;1818.4544636608964;1829.378011476078;1863.450282166764;1867.1504465468179;395.7803419102368;398.9920201595952;831.2269589281905;855.362754747717;938.7371535969803;9692.41845489273;10628.840567391495;10730.78538429227;10812.837807432894;10885.619003335003;422.53099060043326;435.57313832444385;436.71831668573594;441.44378083614237;449.1174841436593;5665.206871038058;5873.735681894325;5893.469587737124;9402.811943761086;9893.950530247303;464935;475301.3523985715;497893;498876;504644.47677761375;43309.56690433119;43823.78088109603;68076.97884531735;69433.65283173551;71718.64140679264;1107.3189988157387;1117.899389054989;1131.5530365505579;1134;1139.0488941733745;14701.852981470476;14911.428061335802;14912.925435372754;15073.246337683291;15175.620609484851;29864.402711945204;30170;30524.38951220919;31820.522692159175;33635.49546756752;39476;41376.58623413848;41648.79175604103;41824;41906.37140442835;6526.5105117117355;6553.541252112306;6838.829029274308;6850.200336047579;7212.2427145149;3494;5994.100884867305;6612.471002319707;9305.534723263945;9863.309568330147;3036.7874248802373;5066.859956509756;8367.707130250412;9338.719838404859;10020;9853.458059806493;10012.39925604437;10037.297389182688;10111.89888101139;10299.485025748832;7051.43588512928;9781.657641982496;9948.900510994798;10191.439470829175;10274.178065754872;8337.333013359039;8851;9343.953280233556;9351.298652601217;9437.245020398213;7419.591922444318;7424.640200859849;7431.162004319025;7497.10034795828;9743.171830394496 13:19:27 INFO - PROCESS | 15838 | |3;mootools.html;1456.446550310882;1469.9191544465054;1631.8449747274012;1759.9736003959952;1784.0187896656835;7412.925870741291;7460.477766556343;7533.962330188341;7716.382689384843;7716.92283077169;7457.66440510177;7485.0643669541305;7504.437167212467;7536.660850261737;7545.320921117099;2211.568744094898;2223.444138965259;2229.1863469833474;2231.6987206727126;2231.9107235710553;2236.4632488202797;2248.2243625949022;2269.7049383580193;2290.4388424835856;2292.541491701658;2205.5368372641765;2217.190725385231;2230.096810791632;2232.5311684546264;2256.2103263857603;2198.307533127068;2221.7556068832414;2221.922232721855;2224.132588290568;2225.9666105008437;2166.0794162480884;2243.2260869999823;2253.301476542277;2263.3210036989003;2267.9886600566892;7352.338289553966;7384.261573842627;7393.2606739326175;7416.666250018762;7419.406447484188;4427.247367947457;4532.8866778330475;4534.9319760203625;4535.229011068126;4597.057603191338;2986.671466138723;3032.757379409642;3131.060681795452;3133.4516459619476;3143.229908672367;955.7371722776222;980.6763767956628;994.462989985407;998.2862253488718;1015.3806178231273;10298.897011029869;10345.32755370906;10367.22245831558;10367.89632103677;10453.163746900229;4118.75287482752;4126.09225970286;4152.211079894811;4200.894977625584;4235.449391579075;8991.640334386682;9020.368574199743;9083.636654533877;9101.271898248124;9120.635174593075;4577.56513131252;4591.17358875399;4592.839250626212;4614.077184563101;4622.19111655459;4120.64018873771;4149.585041495887;4176.373543968429;4216.746995180299;4224.260754367973;3444.9311013779584;3473.3227020730715;3520.383932811748;3527.5943266524164;3561.216532362876;1086.2721976275914;1086.3916206923989;1091.5360971587045;1122.3602546548552;1124.0333313350511;988.0070529118191;991.108002797488;1126.1666366888608;1132.5639628742829;1308.378520202896;7002.75490357835;7068.964655176691;7072.504924655328;7073.257307982691;7115.644217789089;1082.5940272397852;1100.5322737836389;1119.7424592343807;1124.4658787076237;1141.2695874640237;5482.616216864861;5577.525910297589;5602.327720673464;5604.579656525777;5605.411431799684;8768.736937891874;8817.426867253607;9162.450252984709;9196.218321442619;9266.536673166314;8956.238719708897;8999.145081217273;9041.77395565103;9076.954615226881;9151.588178531982;7011.964940175267;7224.891626625605;7316.048913641299;7316.561006339637;7316.817079573159;7037.366637002694;7059.71761129549;7066.258042905626;7107.857842843217;7145.606991615511;8037.075736290401;8203.097659257357;8206.466579672302;8369.874451883104;8406.663733450594;8344.707935222237;8513.40406171562;8545.786355341166;8554.700585479479;8600.440971336842;6536.281009088902;6552.770653027312;6643.833904152435;6653.600783952978;6712.93287067123;7305.671244794104;7366.447516436181;7401.4078873688895;7407.296306851056;7412.6664300107705;6878.518503704692;7049.823754405976;7077.433805295667;7084.610346430995;7145.356917877416;6099.3900609938655;6488;6546.770863019962;6806.965965170142;6954.408875245661;6827.48793840454;6831.69257383409;6909.965450172717;6941.5140940135725;6945.444364450933;6089.147519347206;6092.360302168208;6113.480354169767;6152.354002829818;6159.168512250789;6224.284207316216;6359.300476947439;6370.29926708071;6393.4885209184085;6403.8399040022505 13:19:27 INFO - PROCESS | 15838 | |4;prototype.html;330.91561651778795;334.479883780721;338.3537443482948;341.87692430724934;343.8332408781742;6237.906431403532;6263.561550691454;6277.591956522829;6312.147860038894;6444.452221561173;6240.625562466255;6245.344238854923;6270.467010304118;6278.026905829593;6284.937150628492;4708.92936605952;4727.66906316558;4743.407074115736;4751.524847515238;4756.025014871961;4760.09558183944;4761.095391875532;4780.187368147406;4782.569568738812;4791.712497250159;4636.884077898046;4723.952760472403;4727.5272472752795;4729.503402142777;4732.9526704733025;4689.859304220845;4696.788644510988;4698.577128058491;4710.26990816424;4721.929171062437;4066.877993660195;4071.7964101795087;4079.2045551117544;4079.5104587449696;4081.306177949726;6002.579819412643;6006.669633170174;6007;6025.879482410371;6027.336992930774;5375.677459352412;5488.039593071237;5498.5876059295715;5501.642393244426;5514.862128446821;6652.567583107131;6659.300773418819;6659.433948114416;6676.4992625552795;6678.098456708331;4471.569097888677;4514.977425112854;4535.727856328631;4543.159515489645;4545.250033744428;6782.626955517445;6889.414399776025;6926.341997510279;6952.582845029264;6953.130858642669;4604.769761511978;4629.560191781776;4632.143053535106;4637.420322459692;4641.86074417768;4693.27254275581;4697.614203809884;4698.459677137173;4705.153072446992;4707.693999889996;5480.725963701799;5481.862953426116;5483.533899618497;5486.341639003345;5497.780088796483;6406.583572067801;6693.330666933268;6707.6981535831;6753.8649227015185;6759.391654750998;1620.635357044679;1639.7540368944515;1667.0247904975483;1667.8415550522682;1669.3906724045878;1087.8640169978753;1096.1723898456773;1105.209775010871;1109.9889001109887;1115.7154925493946;6168.9691551542855;6169.8457538561;6223.315435302113;6225.035119556476;6230.345813689588;6734.124563806674;6753.864922701617;6761.357671021246;6778.593284402951;6807.795766127024;6055.303640081359;6119.84700382494;6168.444839964424;6179.227596550431;6220.906686399708;3685;3690.095926498025;3703.4074548072717;3705.444183372516;3706.4988679584812;6989;7039.331263529956;7043.964780176067;7056.54132481387;7064.43484521237;6714.227863795629;6913.481488888354;6948.965255173692;6960.37356637905;6970.790876273619;6962.930370696329;6978.5812851228075;7013.473989450709;7014.438844892498;7034.437245020386;6725.562838415487;6733.966330168514;6736.360045795642;6758.715843989627;6760.290169532128;6510.804675859732;6639.634820084942;6688.866222675422;6696.698648560729;6704.966475167593;6985.26654701249;6996.580205187705;7016.263292354433;7023.122109736283;7052.858942821217;4468.3074123510905;4487.282034874404;4497.550244975476;4500.122476117126;4501.279795232747;6754.966225168842;6767.35710107539;6775.322467753185;6782.491313151435;6935.6878940446795;6729.596224226562;6762.222344430256;6770.390664840188;6772.11962444879;6798.592084474947;6728.663566821737;6737.764178253738;6755.662216889037;6761.864762704817;6781.525293229427;6477.060826180272;6528.608283503005;6607.075009498578;6615.636140012345;6629.403353698191;6754.8649027020165;6779.694913728796;6781.89827152603;6812.14848143982;6825.590464572141;6621.735130594915;6624.6750649869255;6629.668516574248;6630.569013014331;6656.800295991128 13:19:27 INFO - PROCESS | 15838 | |5;yui.html;797.868351721966;804.2078552625667;823.3660081737063;828.7928017995501;831.7380025292031;13323;13367.465301387945;13459.125156864822;13482.05625606208;13510.662233444169;10725.83911241332;11789.882101178986;11807.291562506256;12563.748725025494;12631;748.3938010211732;770.4529783853443;773.891655168274;776.5573623034873;778.828657695309;752.3905636434479;774.1909704358958;774.9496282741632;776.3711393771064;777.4596655324551;799.5802203843;826.9049059358191;833.2001278772356;833.3125171733313;834.2825170353491;801.3989507869098;821.5276216175693;825.3685930263354;825.8018075661798;828.5774255129927;593.4214141212327;593.7298529169261;603.5021107586259;605.8818530386576;610.9205803245594;11139.164562657834;11170.776584468347;11218.831717524243;11255.268407553483;11257.43712814356;10293.433861137635;10378.844317335246;10437.165026797838;10474.109700675452;10860.945695271552;9124.817503649956;9149.993500714916;9205.67780127699;9331.533423328807;9375;3365.5456513370627;3416.6070901846356;3454.084667563098;3480.89557313281;3487.9128021799406;44104.117917641466;44892.10215795666;45259.32111018337;48860.75569622129;49058;9474.810503789886;9497.287703422133;9582.472963987047;9778.315517913677;9892.208623310118;15615.843841561666;15633.218339083;15636.843631563766;15638.374465021272;15738;7222.422206223489;7236.276372362721;7347.853042939111;7376;7623.123340815766;3947.5657677655436;4016.3172260715746;4021.2761702893176;4042.2319759245647;4079.9796001019804;3111.2532992081738;3115.501519756828;3119.313750974782;3131.232847952266;3138.6547479777205;569.3168198162222;589.9941000589939;596.8597379615787;613.9539534534838;614.6772944204239;481.1051444313574;514.4726655178472;529.8357509172168;662.3343539742527;685.4440420246013;8303.252707256375;8904.821903561893;9196.63213471467;9662.178714809179;9812.607495700235;578.6961845031392;600.2616781358953;617.5831313863124;671.5701950751522;678.5453745990199;4143.212789569972;4313.396124542566;4326.264535029052;4339.848105316299;4446.399736035593;55225.72387138039;55739.721301393234;56041.43958560362;56147;56205;50006;50331.74834125806;51093.74453127785;52115.78842115758;53520.73239633855;44641.77679111584;46643.53356466392;49339.25991110136;50151.24773128333;51417.742911285204;8818.162274583905;8993.28053755685;9086.54567271647;9087.136722011399;9314;34407.827960860035;34499.82750086234;34799.65200347964;34847.47728784019;34961;42045.15909681728;42518;43094;44530.55469445394;45320.773396132805;10991.175661825235;11155.062113188469;11162;11342;11536.59621913229;12105.273683579013;12149.210301330386;12220.877791221974;12267.877321226673;12298.446569904198;11011.889881101408;11379.715507112058;11407.657770266906;11615;11937.641870743892;11248.606298779503;11279.943600282275;11363.261388010083;11538.94230528842;11720.941395292968;11344;11819.231749936227;12043.397830108284;12190.75618487643;12263.570775022832;9479.431234125974;9510.904890951002;9523;9532.142107210384;9702.167643780807;9092.172118132541;9255.995937994749;9649.855252171363;9858.112769850748;9882.555285012335 13:19:27 INFO - PROCESS | 15838 | __end_tp_report 13:19:27 INFO - PROCESS | 15838 | __start_cc_report 13:19:27 INFO - PROCESS | 15838 | _x_x_mozilla_cycle_collect,291 13:19:27 INFO - PROCESS | 15838 | __end_cc_report 13:19:27 INFO - PROCESS | 15838 | __startTimestamp1453756767151__endTimestamp 13:19:27 INFO - PROCESS | 15838 | 13:19:27 INFO - PROCESS | 15838 | ------- Summary: start ------- 13:19:27 INFO - PROCESS | 15838 | Number of tests: 6 13:19:27 INFO - PROCESS | 15838 | 13:19:27 INFO - PROCESS | 15838 | [#0] dojo.html Cycles:165 Average:5347.16 Median:5565.83 stddev:595.43 (10.7%) stddev-sans-first:572.61 13:19:27 INFO - PROCESS | 15838 | Values: 3186.1 3235.6 3255.9 3277.1 3286.3 5237.3 5255.8 5298.8 5342.8 5352.6 5250.9 5290.6 5319.9 5321.4 5337.9 4848.9 4917.4 5005.9 5035.1 5077.0 4944.7 5005.4 5017.6 5023.4 5061.1 4826.1 4952.4 4968.3 4969.2 5017.1 4848.6 4903.0 4956.3 4960.5 4994.8 4861.1 4866.1 4873.6 4877.0 4879.7 5156.7 5183.4 5187.8 5208.4 5299.2 5638.9 5674.7 5687.7 5695.7 5699.6 5819.3 5837.0 5852.0 5909.8 5910.7 5436.4 5444.0 5462.6 5465.5 5468.3 5816.1 5913.8 5928.4 5944.0 5983.7 5742.3 5758.0 5763.7 5764.5 5781.9 5766.3 5789.5 5836.8 5840.8 5847.2 5672.7 5680.5 5774.6 5802.0 5803.6 5788.6 5807.3 5835.5 5840.1 5852.0 4422.0 4427.6 4446.5 4455.5 4466.2 3934.6 3950.7 3977.1 4008.1 4038.9 5299.0 5329.6 5348.8 5372.4 5404.8 5640.6 5720.3 5726.1 5728.1 5733.7 5105.2 5130.8 5133.5 5136.2 5170.9 4663.9 4701.4 4712.2 4741.5 4892.2 5923.4 5983.9 5990.3 6001.4 6010.2 5713.6 5750.9 5756.8 5758.4 5764.0 5793.9 5818.7 5893.1 5900.4 5952.9 5589.4 5594.7 5604.6 5608.5 5776.8 5866.8 5877.8 5879.4 5883.5 5897.4 5672.5 5702.9 5706.6 5748.2 5761.0 5603.7 5611.2 5668.1 5671.6 5714.5 5496.8 5539.7 5544.2 5546.1 5558.8 5626.4 5643.4 5666.8 5678.4 5698.1 5437.9 5511.2 5565.8 5585.8 5601.4 13:19:27 INFO - PROCESS | 15838 | 13:19:27 INFO - PROCESS | 15838 | [#1] ext.html Cycles:180 Average:46145.71 Median:35834.00 stddev:77422.82 (216.1%) stddev-sans-first:77564.19 13:19:27 INFO - PROCESS | 15838 | Values: 508.2 533.7 565.0 569.8 571.5 34916.0 35459.6 35826.0 35842.0 35897.3 38017.8 38252.0 38657.6 38713.6 38720.0 8482.3 8629.6 8704.3 8710.3 8712.1 8590.4 8722.5 8724.3 8812.7 8839.7 8774.3 8838.7 8847.3 8896.4 8917.6 8691.8 8743.5 8767.5 8770.4 8814.6 8703.4 8750.7 8821.3 8838.6 8862.3 38949.8 39300.6 39386.8 39387.6 39501.6 2956.8 3015.9 3039.6 3247.6 3402.3 29102.4 30290.2 30305.2 30703.4 30766.7 3933.6 3979.7 4066.4 4133.1 4162.3 248447.0 248733.0 249733.0 249771.0 250661.0 57700.0 57982.0 58100.7 58497.4 58585.4 63237.7 64539.4 64595.7 64693.0 64734.4 13154.7 13318.8 13440.6 13496.1 13541.7 9980.2 10033.3 10061.6 10074.4 10102.7 19752.1 19917.3 19965.6 20008.5 20879.6 8056.9 8288.5 8290.0 8308.8 8333.0 901.6 950.9 999.0 1002.7 1050.8 28489.4 30392.8 31282.8 31296.7 31589.0 975.1 992.9 1018.5 1065.2 1096.6 14470.4 14517.1 14646.7 14786.1 14875.9 334765.0 338412.3 339136.0 339272.0 339473.0 53308.0 54086.0 54124.2 54230.5 54269.5 1272.5 1297.7 1322.9 1327.6 1346.1 28104.9 28689.3 28816.0 29193.3 29226.0 45724.5 46094.0 46381.3 46441.0 46542.5 292084.0 292220.0 292296.0 293593.0 293988.0 27498.2 27833.0 30981.5 31440.8 32667.0 37362.3 37689.6 37747.2 38510.8 38575.0 34449.0 34476.8 34504.1 38542.3 40114.0 33750.0 37474.6 38743.2 39131.8 39386.4 33387.8 33625.2 33861.5 33940.8 34005.8 29653.3 32638.2 32802.5 33021.2 33182.0 24619.6 25506.7 25543.0 25656.8 25804.2 13:19:27 INFO - PROCESS | 15838 | 13:19:27 INFO - PROCESS | 15838 | [#2] jquery.html Cycles:180 Average:24836.90 Median:2419.33 stddev:79784.95 (3297.8%) stddev-sans-first:79987.60 13:19:27 INFO - PROCESS | 15838 | Values: 360.6 363.8 364.0 364.8 365.8 15423.4 16510.5 16682.9 17163.5 18028.2 10473.9 10540.1 10804.5 10810.4 10833.1 4795.3 4798.3 4957.8 5013.3 5015.1 4883.7 4948.1 4973.7 4974.2 4975.1 3689.4 3810.3 4979.0 4995.9 5489.1 5116.1 5280.1 5297.6 5298.4 5308.1 4985.7 5028.8 5263.3 5272.7 5288.8 18251.5 18307.9 19178.9 19984.1 20027.7 1999.1 2046.8 2053.6 2120.1 2123.6 5405.1 10706.3 11202.7 12674.1 12819.1 1736.6 1755.7 1830.1 1834.6 1898.7 50319.2 52473.5 52725.2 53211.5 53276.7 9634.6 9730.7 9920.8 9951.1 10009.6 12962.4 13044.5 13044.9 13057.3 13061.5 6887.1 6979.7 7166.1 7214.9 7230.0 6529.5 6540.4 6570.8 6581.9 6731.1 4331.2 4347.1 4386.0 4397.2 4426.0 1809.5 1818.5 1829.4 1863.5 1867.2 395.8 399.0 831.2 855.4 938.7 9692.4 10628.8 10730.8 10812.8 10885.6 422.5 435.6 436.7 441.4 449.1 5665.2 5873.7 5893.5 9402.8 9894.0 464935.0 475301.4 497893.0 498876.0 504644.5 43309.6 43823.8 68077.0 69433.7 71718.6 1107.3 1117.9 1131.6 1134.0 1139.0 14701.9 14911.4 14912.9 15073.2 15175.6 29864.4 30170.0 30524.4 31820.5 33635.5 39476.0 41376.6 41648.8 41824.0 41906.4 6526.5 6553.5 6838.8 6850.2 7212.2 3494.0 5994.1 6612.5 9305.5 9863.3 3036.8 5066.9 8367.7 9338.7 10020.0 9853.5 10012.4 10037.3 10111.9 10299.5 7051.4 9781.7 9948.9 10191.4 10274.2 8337.3 8851.0 9344.0 9351.3 9437.2 7419.6 7424.6 7431.2 7497.1 9743.2 13:19:27 INFO - PROCESS | 15838 | 13:19:27 INFO - PROCESS | 15838 | [#3] mootools.html Cycles:180 Average:5329.54 Median:6291.79 stddev:2747.36 (43.7%) stddev-sans-first:2739.64 13:19:27 INFO - PROCESS | 15838 | Values: 1456.4 1469.9 1631.8 1760.0 1784.0 7412.9 7460.5 7534.0 7716.4 7716.9 7457.7 7485.1 7504.4 7536.7 7545.3 2211.6 2223.4 2229.2 2231.7 2231.9 2236.5 2248.2 2269.7 2290.4 2292.5 2205.5 2217.2 2230.1 2232.5 2256.2 2198.3 2221.8 2221.9 2224.1 2226.0 2166.1 2243.2 2253.3 2263.3 2268.0 7352.3 7384.3 7393.3 7416.7 7419.4 4427.2 4532.9 4534.9 4535.2 4597.1 2986.7 3032.8 3131.1 3133.5 3143.2 955.7 980.7 994.5 998.3 1015.4 10298.9 10345.3 10367.2 10367.9 10453.2 4118.8 4126.1 4152.2 4200.9 4235.4 8991.6 9020.4 9083.6 9101.3 9120.6 4577.6 4591.2 4592.8 4614.1 4622.2 4120.6 4149.6 4176.4 4216.7 4224.3 3444.9 3473.3 3520.4 3527.6 3561.2 1086.3 1086.4 1091.5 1122.4 1124.0 988.0 991.1 1126.2 1132.6 1308.4 7002.8 7069.0 7072.5 7073.3 7115.6 1082.6 1100.5 1119.7 1124.5 1141.3 5482.6 5577.5 5602.3 5604.6 5605.4 8768.7 8817.4 9162.5 9196.2 9266.5 8956.2 8999.1 9041.8 9077.0 9151.6 7012.0 7224.9 7316.0 7316.6 7316.8 7037.4 7059.7 7066.3 7107.9 7145.6 8037.1 8203.1 8206.5 8369.9 8406.7 8344.7 8513.4 8545.8 8554.7 8600.4 6536.3 6552.8 6643.8 6653.6 6712.9 7305.7 7366.4 7401.4 7407.3 7412.7 6878.5 7049.8 7077.4 7084.6 7145.4 6099.4 6488.0 6546.8 6807.0 6954.4 6827.5 6831.7 6910.0 6941.5 6945.4 6089.1 6092.4 6113.5 6152.4 6159.2 6224.3 6359.3 6370.3 6393.5 6403.8 13:19:27 INFO - PROCESS | 15838 | 13:19:27 INFO - PROCESS | 15838 | [#4] prototype.html Cycles:180 Average:5519.38 Median:6239.27 stddev:1681.75 (27.0%) stddev-sans-first:1640.76 13:19:27 INFO - PROCESS | 15838 | Values: 330.9 334.5 338.4 341.9 343.8 6237.9 6263.6 6277.6 6312.1 6444.5 6240.6 6245.3 6270.5 6278.0 6284.9 4708.9 4727.7 4743.4 4751.5 4756.0 4760.1 4761.1 4780.2 4782.6 4791.7 4636.9 4724.0 4727.5 4729.5 4733.0 4689.9 4696.8 4698.6 4710.3 4721.9 4066.9 4071.8 4079.2 4079.5 4081.3 6002.6 6006.7 6007.0 6025.9 6027.3 5375.7 5488.0 5498.6 5501.6 5514.9 6652.6 6659.3 6659.4 6676.5 6678.1 4471.6 4515.0 4535.7 4543.2 4545.3 6782.6 6889.4 6926.3 6952.6 6953.1 4604.8 4629.6 4632.1 4637.4 4641.9 4693.3 4697.6 4698.5 4705.2 4707.7 5480.7 5481.9 5483.5 5486.3 5497.8 6406.6 6693.3 6707.7 6753.9 6759.4 1620.6 1639.8 1667.0 1667.8 1669.4 1087.9 1096.2 1105.2 1110.0 1115.7 6169.0 6169.8 6223.3 6225.0 6230.3 6734.1 6753.9 6761.4 6778.6 6807.8 6055.3 6119.8 6168.4 6179.2 6220.9 3685.0 3690.1 3703.4 3705.4 3706.5 6989.0 7039.3 7044.0 7056.5 7064.4 6714.2 6913.5 6949.0 6960.4 6970.8 6962.9 6978.6 7013.5 7014.4 7034.4 6725.6 6734.0 6736.4 6758.7 6760.3 6510.8 6639.6 6688.9 6696.7 6705.0 6985.3 6996.6 7016.3 7023.1 7052.9 4468.3 4487.3 4497.6 4500.1 4501.3 6755.0 6767.4 6775.3 6782.5 6935.7 6729.6 6762.2 6770.4 6772.1 6798.6 6728.7 6737.8 6755.7 6761.9 6781.5 6477.1 6528.6 6607.1 6615.6 6629.4 6754.9 6779.7 6781.9 6812.1 6825.6 6621.7 6624.7 6629.7 6630.6 6656.8 13:19:27 INFO - PROCESS | 15838 | 13:19:27 INFO - PROCESS | 15838 | [#5] yui.html Cycles:180 Average:13505.73 Median:50241.50 stddev:15800.36 (31.4%) stddev-sans-first:15815.87 13:19:27 INFO - PROCESS | 15838 | Values: 797.9 804.2 823.4 828.8 831.7 13323.0 13367.5 13459.1 13482.1 13510.7 10725.8 11789.9 11807.3 12563.7 12631.0 748.4 770.5 773.9 776.6 778.8 752.4 774.2 774.9 776.4 777.5 799.6 826.9 833.2 833.3 834.3 801.4 821.5 825.4 825.8 828.6 593.4 593.7 603.5 605.9 610.9 11139.2 11170.8 11218.8 11255.3 11257.4 10293.4 10378.8 10437.2 10474.1 10860.9 9124.8 9150.0 9205.7 9331.5 9375.0 3365.5 3416.6 3454.1 3480.9 3487.9 44104.1 44892.1 45259.3 48860.8 49058.0 9474.8 9497.3 9582.5 9778.3 9892.2 15615.8 15633.2 15636.8 15638.4 15738.0 7222.4 7236.3 7347.9 7376.0 7623.1 3947.6 4016.3 4021.3 4042.2 4080.0 3111.3 3115.5 3119.3 3131.2 3138.7 569.3 590.0 596.9 614.0 614.7 481.1 514.5 529.8 662.3 685.4 8303.3 8904.8 9196.6 9662.2 9812.6 578.7 600.3 617.6 671.6 678.5 4143.2 4313.4 4326.3 4339.8 4446.4 55225.7 55739.7 56041.4 56147.0 56205.0 50006.0 50331.7 51093.7 52115.8 53520.7 44641.8 46643.5 49339.3 50151.2 51417.7 8818.2 8993.3 9086.5 9087.1 9314.0 34407.8 34499.8 34799.7 34847.5 34961.0 42045.2 42518.0 43094.0 44530.6 45320.8 10991.2 11155.1 11162.0 11342.0 11536.6 12105.3 12149.2 12220.9 12267.9 12298.4 11011.9 11379.7 11407.7 11615.0 11937.6 11248.6 11279.9 11363.3 11538.9 11720.9 11344.0 11819.2 12043.4 12190.8 12263.6 9479.4 9510.9 9523.0 9532.1 9702.2 9092.2 9256.0 9649.9 9858.1 9882.6 13:19:27 INFO - PROCESS | 15838 | -------- Summary: end -------- 13:19:27 INFO - PROCESS | 15838 | 13:19:27 INFO - TEST-INFO | 15838: exit 0 13:19:27 INFO - TEST-OK | dromaeo_css | took 1110320ms 13:19:27 INFO - TEST-START | kraken 13:19:27 INFO - operating with platform_type : linux_ 13:19:27 INFO - Initialising browser for kraken test... 13:19:27 INFO - TEST-INFO | started process 16085 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnwNtam/profile http://localhost:38710/getInfo.html) 13:19:31 INFO - PROCESS | 16085 | 13:19:31 INFO - PROCESS | 16085 | (process:16159): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:19:31 INFO - PROCESS | 16085 | __metrics Screen width/height:1600/1200 13:19:31 INFO - PROCESS | 16085 | colorDepth:24 13:19:31 INFO - PROCESS | 16085 | Browser inner width/height: 1024/697 13:19:31 INFO - PROCESS | 16085 | __metrics 13:19:32 INFO - PROCESS | 16085 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:19:32 INFO - TEST-INFO | 16085: exit 0 13:19:32 INFO - Browser initialized. 13:19:32 INFO - Running cycle 1/1 for kraken test... 13:19:32 INFO - TEST-INFO | started process 16208 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnwNtam/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:19:34 INFO - PROCESS | 16208 | 13:19:34 INFO - PROCESS | 16208 | (process:16266): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:19:44 INFO - PROCESS | 16208 | RSS: Main: 150638592 13:19:44 INFO - PROCESS | 16208 | 13:19:47 INFO - PROCESS | 16208 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38710/tests/kraken/driver.html?testName=audio-beat-detection) 13:19:47 INFO - PROCESS | 16208 | RSS: Main: 155025408 13:19:47 INFO - PROCESS | 16208 | 13:19:50 INFO - PROCESS | 16208 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38710/tests/kraken/driver.html?testName=audio-dft) 13:19:51 INFO - PROCESS | 16208 | RSS: Main: 157966336 13:19:51 INFO - PROCESS | 16208 | 13:19:53 INFO - PROCESS | 16208 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38710/tests/kraken/driver.html?testName=audio-fft) 13:19:54 INFO - PROCESS | 16208 | RSS: Main: 153026560 13:19:54 INFO - PROCESS | 16208 | 13:19:56 INFO - PROCESS | 16208 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38710/tests/kraken/driver.html?testName=audio-oscillator) 13:19:57 INFO - PROCESS | 16208 | RSS: Main: 153583616 13:19:57 INFO - PROCESS | 16208 | 13:19:59 INFO - PROCESS | 16208 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38710/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:19:59 INFO - PROCESS | 16208 | RSS: Main: 154189824 13:19:59 INFO - PROCESS | 16208 | 13:20:02 INFO - PROCESS | 16208 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38710/tests/kraken/driver.html?testName=imaging-darkroom) 13:20:03 INFO - PROCESS | 16208 | RSS: Main: 153141248 13:20:03 INFO - PROCESS | 16208 | 13:20:06 INFO - PROCESS | 16208 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38710/tests/kraken/driver.html?testName=imaging-desaturate) 13:20:07 INFO - PROCESS | 16208 | RSS: Main: 154128384 13:20:07 INFO - PROCESS | 16208 | 13:20:10 INFO - PROCESS | 16208 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38710/tests/kraken/driver.html?testName=json-parse-financial) 13:20:10 INFO - PROCESS | 16208 | RSS: Main: 154066944 13:20:10 INFO - PROCESS | 16208 | 13:20:12 INFO - PROCESS | 16208 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38710/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:20:13 INFO - PROCESS | 16208 | RSS: Main: 154501120 13:20:13 INFO - PROCESS | 16208 | 13:20:14 INFO - PROCESS | 16208 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:20:15 INFO - PROCESS | 16208 | RSS: Main: 152563712 13:20:15 INFO - PROCESS | 16208 | 13:20:17 INFO - PROCESS | 16208 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:20:18 INFO - PROCESS | 16208 | RSS: Main: 155033600 13:20:18 INFO - PROCESS | 16208 | 13:20:20 INFO - PROCESS | 16208 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:20:21 INFO - PROCESS | 16208 | RSS: Main: 154951680 13:20:21 INFO - PROCESS | 16208 | 13:20:23 INFO - PROCESS | 16208 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:20:24 INFO - PROCESS | 16208 | RSS: Main: 153014272 13:20:24 INFO - PROCESS | 16208 | 13:20:25 INFO - PROCESS | 16208 | Cycle 1(1): loaded http://localhost:38710/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38710/tests/kraken/driver.html?testName=ai-astar) 13:20:26 INFO - PROCESS | 16208 | RSS: Main: 155643904 13:20:26 INFO - PROCESS | 16208 | 13:20:26 INFO - PROCESS | 16208 | __start_tp_report 13:20:26 INFO - PROCESS | 16208 | _x_x_mozilla_page_load 13:20:26 INFO - PROCESS | 16208 | _x_x_mozilla_page_load_details 13:20:26 INFO - PROCESS | 16208 | |i|pagename|runs| 13:20:26 INFO - PROCESS | 16208 | |0;ai-astar;113;107;112;110;112;126;110;110;113;113 13:20:26 INFO - PROCESS | 16208 | |1;audio-beat-detection;149;125;152;165;126;153;149;135;173;125 13:20:26 INFO - PROCESS | 16208 | |2;audio-dft;163;162;162;163;163;163;161;164;166;162 13:20:26 INFO - PROCESS | 16208 | |3;audio-fft;74;73;73;74;73;162;73;75;74;74 13:20:26 INFO - PROCESS | 16208 | |4;audio-oscillator;96;96;140;96;96;97;139;95;97;138 13:20:26 INFO - PROCESS | 16208 | |5;imaging-gaussian-blur;120;116;115;115;116;117;117;118;115;115 13:20:26 INFO - PROCESS | 16208 | |6;imaging-darkroom;146;147;147;147;148;147;147;147;147;146 13:20:26 INFO - PROCESS | 16208 | |7;imaging-desaturate;98;96;97;97;96;97;97;98;97;96 13:20:26 INFO - PROCESS | 16208 | |8;json-parse-financial;61;61;61;60;60;59;61;60;70;63 13:20:26 INFO - PROCESS | 16208 | |9;json-stringify-tinderbox;70;68;73;68;73;68;68;68;69;68 13:20:26 INFO - PROCESS | 16208 | |10;stanford-crypto-aes;84;82;85;85;90;85;86;83;83;83 13:20:26 INFO - PROCESS | 16208 | |11;stanford-crypto-ccm;115;122;121;119;119;122;119;114;124;118 13:20:26 INFO - PROCESS | 16208 | |12;stanford-crypto-pbkdf2;138;142;145;144;142;130;151;143;142;142 13:20:26 INFO - PROCESS | 16208 | |13;stanford-crypto-sha256-iterative;70;68;66;69;68;67;66;66;66;71 13:20:26 INFO - PROCESS | 16208 | __end_tp_report 13:20:26 INFO - PROCESS | 16208 | __start_cc_report 13:20:26 INFO - PROCESS | 16208 | _x_x_mozilla_cycle_collect,729 13:20:26 INFO - PROCESS | 16208 | __end_cc_report 13:20:26 INFO - PROCESS | 16208 | __startTimestamp1453756826218__endTimestamp 13:20:26 INFO - PROCESS | 16208 | 13:20:26 INFO - PROCESS | 16208 | ------- Summary: start ------- 13:20:26 INFO - PROCESS | 16208 | Number of tests: 14 13:20:26 INFO - PROCESS | 16208 | 13:20:26 INFO - PROCESS | 16208 | [#0] ai-astar Cycles:10 Average:112.60 Median:112.50 stddev:5.08 (4.5%) stddev-sans-first:5.39 13:20:26 INFO - PROCESS | 16208 | Values: 113.0 107.0 112.0 110.0 112.0 126.0 110.0 110.0 113.0 113.0 13:20:26 INFO - PROCESS | 16208 | 13:20:26 INFO - PROCESS | 16208 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:150.50 stddev:16.96 (11.3%) stddev-sans-first:17.94 13:20:26 INFO - PROCESS | 16208 | Values: 149.0 125.0 152.0 165.0 126.0 153.0 149.0 135.0 173.0 125.0 13:20:26 INFO - PROCESS | 16208 | 13:20:26 INFO - PROCESS | 16208 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.37 (0.8%) stddev-sans-first:1.45 13:20:26 INFO - PROCESS | 16208 | Values: 163.0 162.0 162.0 163.0 163.0 163.0 161.0 164.0 166.0 162.0 13:20:26 INFO - PROCESS | 16208 | 13:20:26 INFO - PROCESS | 16208 | [#3] audio-fft Cycles:10 Average:82.50 Median:74.00 stddev:27.94 (37.8%) stddev-sans-first:29.47 13:20:26 INFO - PROCESS | 16208 | Values: 74.0 73.0 73.0 74.0 73.0 162.0 73.0 75.0 74.0 74.0 13:20:26 INFO - PROCESS | 16208 | 13:20:26 INFO - PROCESS | 16208 | [#4] audio-oscillator Cycles:10 Average:109.00 Median:96.00 stddev:20.71 (21.6%) stddev-sans-first:21.43 13:20:26 INFO - PROCESS | 16208 | Values: 96.0 96.0 140.0 96.0 96.0 97.0 139.0 95.0 97.0 138.0 13:20:26 INFO - PROCESS | 16208 | 13:20:26 INFO - PROCESS | 16208 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.50 stddev:1.65 (1.4%) stddev-sans-first:1.12 13:20:26 INFO - PROCESS | 16208 | Values: 120.0 116.0 115.0 115.0 116.0 117.0 117.0 118.0 115.0 115.0 13:20:26 INFO - PROCESS | 16208 | 13:20:26 INFO - PROCESS | 16208 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 13:20:26 INFO - PROCESS | 16208 | Values: 146.0 147.0 147.0 147.0 148.0 147.0 147.0 147.0 147.0 146.0 13:20:26 INFO - PROCESS | 16208 | 13:20:26 INFO - PROCESS | 16208 | [#7] imaging-desaturate Cycles:10 Average:96.90 Median:97.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 13:20:26 INFO - PROCESS | 16208 | Values: 98.0 96.0 97.0 97.0 96.0 97.0 97.0 98.0 97.0 96.0 13:20:26 INFO - PROCESS | 16208 | 13:20:26 INFO - PROCESS | 16208 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:61.00 stddev:3.13 (5.1%) stddev-sans-first:3.32 13:20:26 INFO - PROCESS | 16208 | Values: 61.0 61.0 61.0 60.0 60.0 59.0 61.0 60.0 70.0 63.0 13:20:26 INFO - PROCESS | 16208 | 13:20:26 INFO - PROCESS | 16208 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:68.50 stddev:2.06 (3.0%) stddev-sans-first:2.17 13:20:26 INFO - PROCESS | 16208 | Values: 70.0 68.0 73.0 68.0 73.0 68.0 68.0 68.0 69.0 68.0 13:20:26 INFO - PROCESS | 16208 | 13:20:26 INFO - PROCESS | 16208 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:2.27 (2.7%) stddev-sans-first:2.40 13:20:26 INFO - PROCESS | 16208 | Values: 84.0 82.0 85.0 85.0 90.0 85.0 86.0 83.0 83.0 83.0 13:20:26 INFO - PROCESS | 16208 | 13:20:26 INFO - PROCESS | 16208 | [#11] stanford-crypto-ccm Cycles:10 Average:119.30 Median:120.00 stddev:3.13 (2.6%) stddev-sans-first:2.91 13:20:26 INFO - PROCESS | 16208 | Values: 115.0 122.0 121.0 119.0 119.0 122.0 119.0 114.0 124.0 118.0 13:20:26 INFO - PROCESS | 16208 | 13:20:26 INFO - PROCESS | 16208 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.90 Median:142.50 stddev:5.32 (3.7%) stddev-sans-first:5.45 13:20:26 INFO - PROCESS | 16208 | Values: 138.0 142.0 145.0 144.0 142.0 130.0 151.0 143.0 142.0 142.0 13:20:26 INFO - PROCESS | 16208 | 13:20:26 INFO - PROCESS | 16208 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.83 (2.7%) stddev-sans-first:1.74 13:20:26 INFO - PROCESS | 16208 | Values: 70.0 68.0 66.0 69.0 68.0 67.0 66.0 66.0 66.0 71.0 13:20:26 INFO - PROCESS | 16208 | -------- Summary: end -------- 13:20:26 INFO - PROCESS | 16208 | 13:20:27 INFO - TEST-INFO | 16208: exit 0 13:20:27 INFO - TEST-OK | kraken | took 59323ms 13:20:27 INFO - TEST-START | v8_7 13:20:27 INFO - operating with platform_type : linux_ 13:20:27 INFO - Initialising browser for v8_7 test... 13:20:27 INFO - TEST-INFO | started process 16494 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgRAtnA/profile http://localhost:38710/getInfo.html) 13:20:30 INFO - PROCESS | 16494 | 13:20:30 INFO - PROCESS | 16494 | (process:16568): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:20:31 INFO - PROCESS | 16494 | __metrics Screen width/height:1600/1200 13:20:31 INFO - PROCESS | 16494 | colorDepth:24 13:20:31 INFO - PROCESS | 16494 | Browser inner width/height: 1024/697 13:20:31 INFO - PROCESS | 16494 | __metrics 13:20:31 INFO - PROCESS | 16494 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:20:32 INFO - TEST-INFO | 16494: exit 0 13:20:32 INFO - Browser initialized. 13:20:32 INFO - Running cycle 1/1 for v8_7 test... 13:20:32 INFO - TEST-INFO | started process 16617 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpgRAtnA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:20:33 INFO - PROCESS | 16617 | 13:20:33 INFO - PROCESS | 16617 | (process:16677): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:20:43 INFO - PROCESS | 16617 | RSS: Main: 150151168 13:20:43 INFO - PROCESS | 16617 | 13:21:06 INFO - PROCESS | 16617 | Cycle 1(1): loaded http://localhost:38710/tests/v8_7/run.html (next: http://localhost:38710/tests/v8_7/run.html) 13:21:06 INFO - PROCESS | 16617 | RSS: Main: 151822336 13:21:06 INFO - PROCESS | 16617 | 13:21:06 INFO - PROCESS | 16617 | __start_tp_report 13:21:06 INFO - PROCESS | 16617 | _x_x_mozilla_page_load 13:21:06 INFO - PROCESS | 16617 | _x_x_mozilla_page_load_details 13:21:06 INFO - PROCESS | 16617 | |i|pagename|runs| 13:21:06 INFO - PROCESS | 16617 | |0;Richards;168.94745734076702 13:21:06 INFO - PROCESS | 16617 | |1;DeltaBlue;194.74196689386562 13:21:06 INFO - PROCESS | 16617 | |2;Encrypt;273.7476047084588 13:21:06 INFO - PROCESS | 16617 | |3;Decrypt;5268.421052631579 13:21:06 INFO - PROCESS | 16617 | |4;RayTrace;1077.5862068965516 13:21:06 INFO - PROCESS | 16617 | |5;Earley;727.2727272727273 13:21:06 INFO - PROCESS | 16617 | |6;Boyer;12268.292682926829 13:21:06 INFO - PROCESS | 16617 | |7;RegExp;41260 13:21:06 INFO - PROCESS | 16617 | |8;Splay;610.4053236539625 13:21:06 INFO - PROCESS | 16617 | |9;NavierStokes;4840.579710144928 13:21:06 INFO - PROCESS | 16617 | __end_tp_report 13:21:06 INFO - PROCESS | 16617 | __startTimestamp1453756866698__endTimestamp 13:21:06 INFO - PROCESS | 16617 | 13:21:06 INFO - PROCESS | 16617 | ------- Summary: start ------- 13:21:06 INFO - PROCESS | 16617 | Number of tests: 10 13:21:06 INFO - PROCESS | 16617 | 13:21:06 INFO - PROCESS | 16617 | [#0] Richards Cycles:1 Average:168.95 Median:168.95 stddev:0.00 (0.0%) 13:21:06 INFO - PROCESS | 16617 | Values: 168.9 13:21:06 INFO - PROCESS | 16617 | 13:21:06 INFO - PROCESS | 16617 | [#1] DeltaBlue Cycles:1 Average:194.74 Median:194.74 stddev:0.00 (0.0%) 13:21:06 INFO - PROCESS | 16617 | Values: 194.7 13:21:06 INFO - PROCESS | 16617 | 13:21:06 INFO - PROCESS | 16617 | [#2] Encrypt Cycles:1 Average:273.75 Median:273.75 stddev:0.00 (0.0%) 13:21:06 INFO - PROCESS | 16617 | Values: 273.7 13:21:06 INFO - PROCESS | 16617 | 13:21:06 INFO - PROCESS | 16617 | [#3] Decrypt Cycles:1 Average:5268.42 Median:5268.42 stddev:0.00 (0.0%) 13:21:06 INFO - PROCESS | 16617 | Values: 5268.4 13:21:06 INFO - PROCESS | 16617 | 13:21:06 INFO - PROCESS | 16617 | [#4] RayTrace Cycles:1 Average:1077.59 Median:1077.59 stddev:0.00 (0.0%) 13:21:06 INFO - PROCESS | 16617 | Values: 1077.6 13:21:06 INFO - PROCESS | 16617 | 13:21:06 INFO - PROCESS | 16617 | [#5] Earley Cycles:1 Average:727.27 Median:727.27 stddev:0.00 (0.0%) 13:21:06 INFO - PROCESS | 16617 | Values: 727.3 13:21:06 INFO - PROCESS | 16617 | 13:21:06 INFO - PROCESS | 16617 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 13:21:06 INFO - PROCESS | 16617 | Values: 12268.3 13:21:06 INFO - PROCESS | 16617 | 13:21:06 INFO - PROCESS | 16617 | [#7] RegExp Cycles:1 Average:41260.00 Median:41260.00 stddev:0.00 (0.0%) 13:21:06 INFO - PROCESS | 16617 | Values: 41260.0 13:21:06 INFO - PROCESS | 16617 | 13:21:06 INFO - PROCESS | 16617 | [#8] Splay Cycles:1 Average:610.41 Median:610.41 stddev:0.00 (0.0%) 13:21:06 INFO - PROCESS | 16617 | Values: 610.4 13:21:06 INFO - PROCESS | 16617 | 13:21:06 INFO - PROCESS | 16617 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 13:21:06 INFO - PROCESS | 16617 | Values: 4840.6 13:21:06 INFO - PROCESS | 16617 | -------- Summary: end -------- 13:21:06 INFO - PROCESS | 16617 | 13:21:07 INFO - TEST-INFO | 16617: exit 0 13:21:07 INFO - TEST-OK | v8_7 | took 40490ms 13:21:07 INFO - SUITE-END | took 1210s 13:21:07 INFO - Completed test suite (00:20:10) 13:21:07 INFO - Working with test: dromaeo_css 13:21:07 INFO - Generating results file: dromaeo_css 13:21:07 INFO - Working with test: kraken 13:21:07 INFO - Generating results file: kraken 13:21:07 INFO - javascript benchmark 13:21:07 INFO - Working with test: v8_7 13:21:07 INFO - Generating results file: v8_7 13:21:07 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:21:07 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 13:21:07 INFO - process_Request line: dromaeo_css 6750.95 graph.html#tests=[[72,63,43]] 13:21:07 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:21:07 INFO - process_Request line: kraken 1516.80 graph.html#tests=[[232,63,43]] 13:21:07 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:21:07 INFO - process_Request line: v8_7 20211.00 graph.html#tests=[[230,63,43]] 13:21:07 INFO - RETURN: dromaeo_css: 6750.95 13:21:07 INFO - RETURN: kraken: 1516.80 13:21:07 INFO - RETURN: v8_7: 20211.00 13:21:07 INFO - javascript benchmark 13:21:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3186.060112266881, 3235.6440791512914, 3255.9348813023726, 3277.0660361796877, 3286.2770190558085, 5237.319148510688, 5255.789768409259, 5298.788048478056, 5342.759575819093, 5352.598555108368, 5250.8687282817855, 5290.576753859692, 5319.867003324919, 5321.414644389114, 5337.919931201035, 4848.927266091003, 4917.4099108107075, 5005.899882002358, 5035.144025515653, 5076.974615126937, 4944.703317800943, 5005.374328208974, 5017.64876458648, 5023.372078490189, 5061.114304996611, 4826.107170173529, 4952.4057113146655, 4968.279599458095, 4969.229769385751, 5017.071841709296, 4848.587870031051, 4902.975485122587, 4956.281339205831, 4960.454350021495, 4994.775235114393, 4861.118017363983, 4866.124097662419, 4873.585745211662, 4877.0489754497885, 4879.731614761186, 5156.664816786934, 5183.403908550527, 5187.8184263550975, 5208.401033881114, 5299.205119232108, 5638.915416268759, 5674.659520428746, 5687.7156142192725, 5695.686737229451, 5699.57253206007, 5819.301683797929, 5837.0, 5851.970740146272, 5909.7636094556165, 5910.704464776787, 5436.401995780461, 5444.047291723932, 5462.617616766828, 5465.453454654503, 5468.2891224141, 5816.069428891442, 5913.763449461973, 5928.436798504135, 5943.970280148658, 5983.6708981005595, 5742.339630942495, 5757.971210143923, 5763.6541807491685, 5764.510016648548, 5781.8554536136935, 5766.250387449605, 5789.478946894799, 5836.766529338779, 5840.795572154954, 5847.152162936351, 5672.744726487318, 5680.5455563554815, 5774.566907481955, 5802.0, 5803.622764520293, 5788.623739456922, 5807.303123625107, 5835.533157347402, 5840.065589505659, 5852.034414321674, 4422.0, 4427.645788336926, 4446.510883802779, 4455.509893911667, 4466.196084704784, 3934.626210510054, 3950.6839452843706, 3977.105151340925, 4008.098177909947, 4038.9498730330324, 5299.0, 5329.626926115212, 5348.786048558092, 5372.409035006146, 5404.83785486436, 5640.633358831663, 5720.256366672306, 5726.055200891807, 5728.112142617901, 5733.684647344436, 5105.15764898795, 5130.820421285312, 5133.512316329943, 5136.203888397305, 5170.922436163461, 4663.860084197479, 4701.412323459567, 4712.175369310357, 4741.502142275081, 4892.217245240744, 5923.4076592340425, 5983.940160598426, 5990.281166260077, 6001.36985616504, 6010.158577799111, 5713.628614140068, 5750.942490575125, 5756.769729210785, 5758.395368486249, 5764.048931926185, 5793.884122317614, 5818.709064546841, 5893.116032595145, 5900.409959004237, 5952.940470595238, 5589.413111623384, 5594.748236329294, 5604.607677462538, 5608.523275521627, 5776.797812076557, 5866.765329386777, 5877.823665289877, 5879.353271140086, 5883.499902508334, 5897.410258974069, 5672.4894759471845, 5702.857428564319, 5706.572007099401, 5748.166515855261, 5761.020626493422, 5603.719814009365, 5611.214429979725, 5668.093105103164, 5671.631343962629, 5714.542836573148, 5496.7526461308535, 5539.695316757456, 5544.22380866687, 5546.112621980464, 5558.777648893999, 5626.35296940857, 5643.435656434323, 5666.829995100154, 5678.3753787084215, 5698.088305871206, 5437.918431223456, 5511.200875873056, 5565.833025009256, 5585.776568937197, 5601.355844077983], "unit": "score", "name": "dojo.html", "value": 5308.7186065069955}, {"lowerIsBetter": false, "replicates": [508.2401809295102, 533.6557920141511, 564.9745761440735, 569.8347479231023, 571.5427657873702, 34916.0, 35459.645403545954, 35826.0, 35842.0, 35897.28205435893, 38017.80991095048, 38252.0, 38657.613423865754, 38713.612863871356, 38720.0, 8482.279006284472, 8629.568521573896, 8704.30365570756, 8710.259627931633, 8712.128787121268, 8590.355723320745, 8722.476651400904, 8724.345674074439, 8812.691555795549, 8839.690610828622, 8774.298056155525, 8838.734837954871, 8847.336449766293, 8896.377253592218, 8917.55412229386, 8691.826163476726, 8743.519106449143, 8767.51778652177, 8770.386072974894, 8814.64741410346, 8703.390762646553, 8750.737477875611, 8821.294296456268, 8838.55807209637, 8862.291016718647, 38949.80525097385, 39300.60699392998, 39386.80306598449, 39387.60612393868, 39501.60498395037, 2956.822590644568, 3015.9187280906526, 3039.559263906743, 3247.561579186803, 3402.268512269849, 29102.417951640848, 30290.24274393158, 30305.242368940733, 30703.385932281228, 30766.69233307683, 3933.6263055009726, 3979.7214195006363, 4066.430699702044, 4133.0700592366475, 4162.250794856925, 248447.0, 248733.0, 249733.0, 249771.0, 250661.0, 57700.0, 57982.0, 58100.70949645225, 58497.415025850045, 58585.41414585885, 63237.68381158157, 64539.35460645334, 64595.677021615535, 64693.0, 64734.35265647378, 13154.671133221555, 13318.800217996737, 13440.596782096552, 13496.055276130774, 13541.729165416833, 9980.151687106532, 10033.347832390871, 10061.647842325483, 10074.44590547527, 10102.747431314276, 19752.11115499806, 19917.30289439863, 19965.60068798616, 20008.49978750543, 20879.598846132587, 8056.919430805734, 8288.50268983863, 8290.0, 8308.750737477885, 8332.958335208406, 901.6258252825004, 950.8954015058338, 998.9500524973722, 1002.7042022603204, 1050.7898420315814, 28489.43021139607, 30392.848035759678, 31282.843585781924, 31296.687033129834, 31589.0, 975.1321324021626, 992.9007099290158, 1018.4856647393019, 1065.248999455382, 1096.555894862582, 14470.421183152555, 14517.128972261698, 14646.707065858624, 14786.112833229825, 14875.925620372045, 334765.0, 338412.30793845875, 339136.0, 339272.0, 339473.0, 53308.0, 54086.0, 54124.188137177975, 54230.45769542333, 54269.45730542644, 1272.5100836178137, 1297.6820678933532, 1322.9338533073308, 1327.6481732340937, 1346.1048402812216, 28104.85947570249, 28689.262147570986, 28815.9729137627, 29193.270168245963, 29225.97709080257, 45724.54275457203, 46094.0, 46381.304280436496, 46441.0, 46542.53457465382, 292084.0, 292220.0, 292296.0, 293593.0, 293988.0, 27498.17505474839, 27833.0, 30981.53527697041, 31440.842795785873, 32667.0, 37362.2527549442, 37689.62310376861, 37747.245055098196, 38510.80744596259, 38575.0, 34449.0, 34476.82761586176, 34504.13739656529, 38542.33847784456, 40113.99715007148, 33750.0, 37474.625253747115, 38743.2251354977, 39131.80434097811, 39386.40920386139, 33387.83306083454, 33625.15937101494, 33861.492077618364, 33940.83029584836, 34005.82997084999, 29653.25866853346, 32638.184045398106, 32802.50796238106, 33021.17447063843, 33182.0, 24619.63070553979, 25506.74493255044, 25543.0, 25656.844172460384, 25804.225873223833], "unit": "score", "name": "ext.html", "value": 18190.200756503764}, {"lowerIsBetter": false, "replicates": [360.624950051946, 363.8490026638947, 363.95996440391554, 364.79571439993595, 365.75677174678833, 15423.383064677413, 16510.504684859443, 16682.91658541707, 17163.455289023987, 18028.188731507096, 10473.947630261857, 10540.104091152241, 10804.459777011158, 10810.35137891727, 10833.079188269006, 4795.2807078938085, 4798.304245884345, 4957.752112394384, 5013.298138260647, 5015.147424937751, 4883.658143929926, 4948.134076536592, 4973.676711013791, 4974.204127339626, 4975.12935236334, 3689.3912504436735, 3810.2760475509704, 4979.0, 4995.850124496253, 5489.149181876795, 5116.104681680709, 5280.07598670235, 5297.576193904498, 5298.36419629645, 5308.0710875596615, 4985.675931064469, 5028.84913452597, 5263.26314315996, 5272.710000949946, 5288.8413347599635, 18251.543711407186, 18307.908460457613, 19178.904105479523, 19984.100715467837, 20027.6995845061, 1999.1103958738368, 2046.8055534724326, 2053.5790163016545, 2120.056574824204, 2123.6177488052144, 5405.135178371442, 10706.250562460631, 11202.719932001684, 12674.112812103156, 12819.102662813606, 1736.6179440523065, 1755.7278621813512, 1830.0941034188163, 1834.5688763140652, 1898.686716691744, 50319.24521132186, 52473.47526524724, 52725.20912186358, 53211.467885321035, 53276.73361633206, 9634.566444510014, 9730.659426920023, 9920.80158396828, 9951.054649808257, 10009.649662261785, 12962.351882405843, 13044.54344097971, 13044.934775326063, 13057.281849498178, 13061.542846000344, 6887.104676392137, 6979.685914133876, 7166.104236970379, 7214.855702885913, 7229.987801707765, 6529.477641788645, 6540.411362977355, 6570.8357291068105, 6581.934180658132, 6731.124953755981, 4331.242032644274, 4347.087111706577, 4385.956140438555, 4397.208502469586, 4426.048399594103, 1809.5204770735766, 1818.4544636608964, 1829.378011476078, 1863.450282166764, 1867.1504465468179, 395.7803419102368, 398.9920201595952, 831.2269589281905, 855.362754747717, 938.7371535969803, 9692.41845489273, 10628.840567391495, 10730.78538429227, 10812.837807432894, 10885.619003335003, 422.53099060043326, 435.57313832444385, 436.71831668573594, 441.44378083614237, 449.1174841436593, 5665.206871038058, 5873.735681894325, 5893.469587737124, 9402.811943761086, 9893.950530247303, 464935.0, 475301.3523985715, 497893.0, 498876.0, 504644.47677761375, 43309.56690433119, 43823.78088109603, 68076.97884531735, 69433.65283173551, 71718.64140679264, 1107.3189988157387, 1117.899389054989, 1131.5530365505579, 1134.0, 1139.0488941733745, 14701.852981470476, 14911.428061335802, 14912.925435372754, 15073.246337683291, 15175.620609484851, 29864.402711945204, 30170.0, 30524.38951220919, 31820.522692159175, 33635.49546756752, 39476.0, 41376.58623413848, 41648.79175604103, 41824.0, 41906.37140442835, 6526.5105117117355, 6553.541252112306, 6838.829029274308, 6850.200336047579, 7212.2427145149, 3494.0, 5994.100884867305, 6612.471002319707, 9305.534723263945, 9863.309568330147, 3036.7874248802373, 5066.859956509756, 8367.707130250412, 9338.719838404859, 10020.0, 9853.458059806493, 10012.39925604437, 10037.297389182688, 10111.89888101139, 10299.485025748832, 7051.43588512928, 9781.657641982496, 9948.900510994798, 10191.439470829175, 10274.178065754872, 8337.333013359039, 8851.0, 9343.953280233556, 9351.298652601217, 9437.245020398213, 7419.591922444318, 7424.640200859849, 7431.162004319025, 7497.10034795828, 9743.171830394496], "unit": "score", "name": "jquery.html", "value": 7316.289455119798}, {"lowerIsBetter": false, "replicates": [1456.446550310882, 1469.9191544465054, 1631.8449747274012, 1759.9736003959952, 1784.0187896656835, 7412.925870741291, 7460.477766556343, 7533.962330188341, 7716.382689384843, 7716.92283077169, 7457.66440510177, 7485.0643669541305, 7504.437167212467, 7536.660850261737, 7545.320921117099, 2211.568744094898, 2223.444138965259, 2229.1863469833474, 2231.6987206727126, 2231.9107235710553, 2236.4632488202797, 2248.2243625949022, 2269.7049383580193, 2290.4388424835856, 2292.541491701658, 2205.5368372641765, 2217.190725385231, 2230.096810791632, 2232.5311684546264, 2256.2103263857603, 2198.307533127068, 2221.7556068832414, 2221.922232721855, 2224.132588290568, 2225.9666105008437, 2166.0794162480884, 2243.2260869999823, 2253.301476542277, 2263.3210036989003, 2267.9886600566892, 7352.338289553966, 7384.261573842627, 7393.2606739326175, 7416.666250018762, 7419.406447484188, 4427.247367947457, 4532.8866778330475, 4534.9319760203625, 4535.229011068126, 4597.057603191338, 2986.671466138723, 3032.757379409642, 3131.060681795452, 3133.4516459619476, 3143.229908672367, 955.7371722776222, 980.6763767956628, 994.462989985407, 998.2862253488718, 1015.3806178231273, 10298.897011029869, 10345.32755370906, 10367.22245831558, 10367.89632103677, 10453.163746900229, 4118.75287482752, 4126.09225970286, 4152.211079894811, 4200.894977625584, 4235.449391579075, 8991.640334386682, 9020.368574199743, 9083.636654533877, 9101.271898248124, 9120.635174593075, 4577.56513131252, 4591.17358875399, 4592.839250626212, 4614.077184563101, 4622.19111655459, 4120.64018873771, 4149.585041495887, 4176.373543968429, 4216.746995180299, 4224.260754367973, 3444.9311013779584, 3473.3227020730715, 3520.383932811748, 3527.5943266524164, 3561.216532362876, 1086.2721976275914, 1086.3916206923989, 1091.5360971587045, 1122.3602546548552, 1124.0333313350511, 988.0070529118191, 991.108002797488, 1126.1666366888608, 1132.5639628742829, 1308.378520202896, 7002.75490357835, 7068.964655176691, 7072.504924655328, 7073.257307982691, 7115.644217789089, 1082.5940272397852, 1100.5322737836389, 1119.7424592343807, 1124.4658787076237, 1141.2695874640237, 5482.616216864861, 5577.525910297589, 5602.327720673464, 5604.579656525777, 5605.411431799684, 8768.736937891874, 8817.426867253607, 9162.450252984709, 9196.218321442619, 9266.536673166314, 8956.238719708897, 8999.145081217273, 9041.77395565103, 9076.954615226881, 9151.588178531982, 7011.964940175267, 7224.891626625605, 7316.048913641299, 7316.561006339637, 7316.817079573159, 7037.366637002694, 7059.71761129549, 7066.258042905626, 7107.857842843217, 7145.606991615511, 8037.075736290401, 8203.097659257357, 8206.466579672302, 8369.874451883104, 8406.663733450594, 8344.707935222237, 8513.40406171562, 8545.786355341166, 8554.700585479479, 8600.440971336842, 6536.281009088902, 6552.770653027312, 6643.833904152435, 6653.600783952978, 6712.93287067123, 7305.671244794104, 7366.447516436181, 7401.4078873688895, 7407.296306851056, 7412.6664300107705, 6878.518503704692, 7049.823754405976, 7077.433805295667, 7084.610346430995, 7145.356917877416, 6099.3900609938655, 6488.0, 6546.770863019962, 6806.965965170142, 6954.408875245661, 6827.48793840454, 6831.69257383409, 6909.965450172717, 6941.5140940135725, 6945.444364450933, 6089.147519347206, 6092.360302168208, 6113.480354169767, 6152.354002829818, 6159.168512250789, 6224.284207316216, 6359.300476947439, 6370.29926708071, 6393.4885209184085, 6403.8399040022505], "unit": "score", "name": "mootools.html", "value": 4388.485434217166}, {"lowerIsBetter": false, "replicates": [330.91561651778795, 334.479883780721, 338.3537443482948, 341.87692430724934, 343.8332408781742, 6237.906431403532, 6263.561550691454, 6277.591956522829, 6312.147860038894, 6444.452221561173, 6240.625562466255, 6245.344238854923, 6270.467010304118, 6278.026905829593, 6284.937150628492, 4708.92936605952, 4727.66906316558, 4743.407074115736, 4751.524847515238, 4756.025014871961, 4760.09558183944, 4761.095391875532, 4780.187368147406, 4782.569568738812, 4791.712497250159, 4636.884077898046, 4723.952760472403, 4727.5272472752795, 4729.503402142777, 4732.9526704733025, 4689.859304220845, 4696.788644510988, 4698.577128058491, 4710.26990816424, 4721.929171062437, 4066.877993660195, 4071.7964101795087, 4079.2045551117544, 4079.5104587449696, 4081.306177949726, 6002.579819412643, 6006.669633170174, 6007.0, 6025.879482410371, 6027.336992930774, 5375.677459352412, 5488.039593071237, 5498.5876059295715, 5501.642393244426, 5514.862128446821, 6652.567583107131, 6659.300773418819, 6659.433948114416, 6676.4992625552795, 6678.098456708331, 4471.569097888677, 4514.977425112854, 4535.727856328631, 4543.159515489645, 4545.250033744428, 6782.626955517445, 6889.414399776025, 6926.341997510279, 6952.582845029264, 6953.130858642669, 4604.769761511978, 4629.560191781776, 4632.143053535106, 4637.420322459692, 4641.86074417768, 4693.27254275581, 4697.614203809884, 4698.459677137173, 4705.153072446992, 4707.693999889996, 5480.725963701799, 5481.862953426116, 5483.533899618497, 5486.341639003345, 5497.780088796483, 6406.583572067801, 6693.330666933268, 6707.6981535831, 6753.8649227015185, 6759.391654750998, 1620.635357044679, 1639.7540368944515, 1667.0247904975483, 1667.8415550522682, 1669.3906724045878, 1087.8640169978753, 1096.1723898456773, 1105.209775010871, 1109.9889001109887, 1115.7154925493946, 6168.9691551542855, 6169.8457538561, 6223.315435302113, 6225.035119556476, 6230.345813689588, 6734.124563806674, 6753.864922701617, 6761.357671021246, 6778.593284402951, 6807.795766127024, 6055.303640081359, 6119.84700382494, 6168.444839964424, 6179.227596550431, 6220.906686399708, 3685.0, 3690.095926498025, 3703.4074548072717, 3705.444183372516, 3706.4988679584812, 6989.0, 7039.331263529956, 7043.964780176067, 7056.54132481387, 7064.43484521237, 6714.227863795629, 6913.481488888354, 6948.965255173692, 6960.37356637905, 6970.790876273619, 6962.930370696329, 6978.5812851228075, 7013.473989450709, 7014.438844892498, 7034.437245020386, 6725.562838415487, 6733.966330168514, 6736.360045795642, 6758.715843989627, 6760.290169532128, 6510.804675859732, 6639.634820084942, 6688.866222675422, 6696.698648560729, 6704.966475167593, 6985.26654701249, 6996.580205187705, 7016.263292354433, 7023.122109736283, 7052.858942821217, 4468.3074123510905, 4487.282034874404, 4497.550244975476, 4500.122476117126, 4501.279795232747, 6754.966225168842, 6767.35710107539, 6775.322467753185, 6782.491313151435, 6935.6878940446795, 6729.596224226562, 6762.222344430256, 6770.390664840188, 6772.11962444879, 6798.592084474947, 6728.663566821737, 6737.764178253738, 6755.662216889037, 6761.864762704817, 6781.525293229427, 6477.060826180272, 6528.608283503005, 6607.075009498578, 6615.636140012345, 6629.403353698191, 6754.8649027020165, 6779.694913728796, 6781.89827152603, 6812.14848143982, 6825.590464572141, 6621.735130594915, 6624.6750649869255, 6629.668516574248, 6630.569013014331, 6656.800295991128], "unit": "score", "name": "prototype.html", "value": 4966.950845779915}, {"lowerIsBetter": false, "replicates": [797.868351721966, 804.2078552625667, 823.3660081737063, 828.7928017995501, 831.7380025292031, 13323.0, 13367.465301387945, 13459.125156864822, 13482.05625606208, 13510.662233444169, 10725.83911241332, 11789.882101178986, 11807.291562506256, 12563.748725025494, 12631.0, 748.3938010211732, 770.4529783853443, 773.891655168274, 776.5573623034873, 778.828657695309, 752.3905636434479, 774.1909704358958, 774.9496282741632, 776.3711393771064, 777.4596655324551, 799.5802203843, 826.9049059358191, 833.2001278772356, 833.3125171733313, 834.2825170353491, 801.3989507869098, 821.5276216175693, 825.3685930263354, 825.8018075661798, 828.5774255129927, 593.4214141212327, 593.7298529169261, 603.5021107586259, 605.8818530386576, 610.9205803245594, 11139.164562657834, 11170.776584468347, 11218.831717524243, 11255.268407553483, 11257.43712814356, 10293.433861137635, 10378.844317335246, 10437.165026797838, 10474.109700675452, 10860.945695271552, 9124.817503649956, 9149.993500714916, 9205.67780127699, 9331.533423328807, 9375.0, 3365.5456513370627, 3416.6070901846356, 3454.084667563098, 3480.89557313281, 3487.9128021799406, 44104.117917641466, 44892.10215795666, 45259.32111018337, 48860.75569622129, 49058.0, 9474.810503789886, 9497.287703422133, 9582.472963987047, 9778.315517913677, 9892.208623310118, 15615.843841561666, 15633.218339083, 15636.843631563766, 15638.374465021272, 15738.0, 7222.422206223489, 7236.276372362721, 7347.853042939111, 7376.0, 7623.123340815766, 3947.5657677655436, 4016.3172260715746, 4021.2761702893176, 4042.2319759245647, 4079.9796001019804, 3111.2532992081738, 3115.501519756828, 3119.313750974782, 3131.232847952266, 3138.6547479777205, 569.3168198162222, 589.9941000589939, 596.8597379615787, 613.9539534534838, 614.6772944204239, 481.1051444313574, 514.4726655178472, 529.8357509172168, 662.3343539742527, 685.4440420246013, 8303.252707256375, 8904.821903561893, 9196.63213471467, 9662.178714809179, 9812.607495700235, 578.6961845031392, 600.2616781358953, 617.5831313863124, 671.5701950751522, 678.5453745990199, 4143.212789569972, 4313.396124542566, 4326.264535029052, 4339.848105316299, 4446.399736035593, 55225.72387138039, 55739.721301393234, 56041.43958560362, 56147.0, 56205.0, 50006.0, 50331.74834125806, 51093.74453127785, 52115.78842115758, 53520.73239633855, 44641.77679111584, 46643.53356466392, 49339.25991110136, 50151.24773128333, 51417.742911285204, 8818.162274583905, 8993.28053755685, 9086.54567271647, 9087.136722011399, 9314.0, 34407.827960860035, 34499.82750086234, 34799.65200347964, 34847.47728784019, 34961.0, 42045.15909681728, 42518.0, 43094.0, 44530.55469445394, 45320.773396132805, 10991.175661825235, 11155.062113188469, 11162.0, 11342.0, 11536.59621913229, 12105.273683579013, 12149.210301330386, 12220.877791221974, 12267.877321226673, 12298.446569904198, 11011.889881101408, 11379.715507112058, 11407.657770266906, 11615.0, 11937.641870743892, 11248.606298779503, 11279.943600282275, 11363.261388010083, 11538.94230528842, 11720.941395292968, 11344.0, 11819.231749936227, 12043.397830108284, 12190.75618487643, 12263.570775022832, 9479.431234125974, 9510.904890951002, 9523.0, 9532.142107210384, 9702.167643780807, 9092.172118132541, 9255.995937994749, 9649.855252171363, 9858.112769850748, 9882.555285012335], "unit": "score", "name": "yui.html", "value": 6146.510039101791}], "name": "dromaeo_css", "value": 6750.94469145846}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 112.0, 110.0, 112.0, 126.0, 110.0, 110.0, 113.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.6}, {"lowerIsBetter": true, "replicates": [149.0, 125.0, 152.0, 165.0, 126.0, 153.0, 149.0, 135.0, 173.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 145.2}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 163.0, 163.0, 163.0, 161.0, 164.0, 166.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.9}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 73.0, 74.0, 73.0, 162.0, 73.0, 75.0, 74.0, 74.0], "unit": "score", "name": "audio-fft", "value": 82.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 140.0, 96.0, 96.0, 97.0, 139.0, 95.0, 97.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 109.0}, {"lowerIsBetter": true, "replicates": [120.0, 116.0, 115.0, 115.0, 116.0, 117.0, 117.0, 118.0, 115.0, 115.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.4}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 97.0, 97.0, 96.0, 97.0, 97.0, 98.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.9}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 61.0, 60.0, 60.0, 59.0, 61.0, 60.0, 70.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 61.6}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 73.0, 68.0, 73.0, 68.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 85.0, 85.0, 90.0, 85.0, 86.0, 83.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [115.0, 122.0, 121.0, 119.0, 119.0, 122.0, 119.0, 114.0, 124.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.3}, {"lowerIsBetter": true, "replicates": [138.0, 142.0, 145.0, 144.0, 142.0, 130.0, 151.0, 143.0, 142.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.9}, {"lowerIsBetter": true, "replicates": [70.0, 68.0, 66.0, 69.0, 68.0, 67.0, 66.0, 66.0, 66.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1516.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.94745734076702], "unit": "score", "name": "Richards", "value": 208.952538}, {"lowerIsBetter": false, "replicates": [194.74196689386562], "unit": "score", "name": "DeltaBlue", "value": 339.51593000000014}, {"lowerIsBetter": false, "replicates": [273.7476047084588], "unit": "score", "name": "Encrypt", "value": 972.3591929999996}, {"lowerIsBetter": false, "replicates": [5268.421052631579], "unit": "score", "name": "Decrypt", "value": 50.52386613386611}, {"lowerIsBetter": false, "replicates": [1077.5862068965516], "unit": "score", "name": "RayTrace", "value": 686.7097920000001}, {"lowerIsBetter": false, "replicates": [727.2727272727273], "unit": "score", "name": "Earley", "value": 916.3866250000003}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [41260.0], "unit": "score", "name": "RegExp", "value": 22.079132331555996}, {"lowerIsBetter": false, "replicates": [610.4053236539625], "unit": "score", "name": "Splay", "value": 133.5030951437066}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20211.004736738385}]} 13:21:07 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20211.00"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1516.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6750.95"}}} 13:21:07 INFO - Return code: 0 13:21:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:21:08 INFO - # TBPL SUCCESS # 13:21:08 INFO - Running post-action listener: _resource_record_post_action 13:21:08 INFO - Running post-run listener: _resource_record_post_run 13:21:09 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 554635264; Read time: 8; Write time: 437184 13:21:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 236429312; Read time: 0; Write time: 233200 13:21:09 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 4096; Write bytes: 314327040; Read time: 8; Write time: 203512 13:21:09 INFO - Running post-run listener: _upload_blobber_files 13:21:09 INFO - Blob upload gear active. 13:21:09 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 13:21:09 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:21:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 13:21:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 13:21:09 INFO - (blobuploader) - INFO - Open directory for files ... 13:21:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:21:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:21:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:21:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:21:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:21:15 INFO - (blobuploader) - INFO - Done attempting. 13:21:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:21:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:21:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:21:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:21:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:21:16 INFO - (blobuploader) - INFO - Done attempting. 13:21:16 INFO - (blobuploader) - INFO - Iteration through files over. 13:21:16 INFO - Return code: 0 13:21:16 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 13:21:16 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 13:21:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/16740a0f20db4a5366baae39450678d5e8d2a992a14124fd7eddb3e4dc9be1c5d709b7b5c466ad1168b9fd74d80b811950446f64b4e8bc6373b966b21ae3e43d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3fe4f627258cedf4fcbcaad3fc98ea89af6b6f674b8ea2f798f0a1be77a4f74f30cacb6d3098341277bca9c60dbe39879e306a25b4481c37b876e577bafbece"} 13:21:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 13:21:16 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 13:21:16 INFO - Contents: 13:21:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/16740a0f20db4a5366baae39450678d5e8d2a992a14124fd7eddb3e4dc9be1c5d709b7b5c466ad1168b9fd74d80b811950446f64b4e8bc6373b966b21ae3e43d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3fe4f627258cedf4fcbcaad3fc98ea89af6b6f674b8ea2f798f0a1be77a4f74f30cacb6d3098341277bca9c60dbe39879e306a25b4481c37b876e577bafbece"} 13:21:16 INFO - Running post-run listener: copy_logs_to_upload_dir 13:21:16 INFO - Copying logs to upload dir... 13:21:16 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 13:21:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.256578 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-01-25 13:21:16.678662) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 13:21:16.684180) ========= 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=6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410 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/16740a0f20db4a5366baae39450678d5e8d2a992a14124fd7eddb3e4dc9be1c5d709b7b5c466ad1168b9fd74d80b811950446f64b4e8bc6373b966b21ae3e43d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3fe4f627258cedf4fcbcaad3fc98ea89af6b6f674b8ea2f798f0a1be77a4f74f30cacb6d3098341277bca9c60dbe39879e306a25b4481c37b876e577bafbece"} build_url:https://queue.taskcluster.net/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011534 build_url: 'https://queue.taskcluster.net/v1/task/fT1HTkroQAKWE8xWwtMv_A/artifacts/public/build/firefox-46.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/16740a0f20db4a5366baae39450678d5e8d2a992a14124fd7eddb3e4dc9be1c5d709b7b5c466ad1168b9fd74d80b811950446f64b4e8bc6373b966b21ae3e43d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e3fe4f627258cedf4fcbcaad3fc98ea89af6b6f674b8ea2f798f0a1be77a4f74f30cacb6d3098341277bca9c60dbe39879e306a25b4481c37b876e577bafbece"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-25 13:21:16.713692) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 13:21:16.714015) ========= 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=6dbc10da6d83fee962c624be000001a8-1453755602.655527-301666410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004712 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 13:21:16.798885) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 13:21:16.799192) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 13:21:16.799502) ========= ========= Total master_lag: 0.27 =========