builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-012 starttime: 1450838789.75 results: success (0) buildid: 20151222163013 builduid: c0e1d3cd11554a6c95bce502346bab2a revision: d86b3de54ca00d1e14ca7b0127dbe8b4d977857d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:29.746872) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:29.747558) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:29.748038) ========= 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=928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006297 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:29.773602) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:29.774102) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:29.788148) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:29.788552) ========= 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=928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004593 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:29.838514) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:29.838875) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:29.839324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:29.839643) ========= 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=928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-22 18:46:30-- 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% 225M=0s 2015-12-22 18:46:30 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093267 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:29.948289) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:29.948662) ========= 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=928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022402 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:30.000573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:30.000962) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d86b3de54ca00d1e14ca7b0127dbe8b4d977857d --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 d86b3de54ca00d1e14ca7b0127dbe8b4d977857d --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=928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-22 18:46:30,478 truncating revision to first 12 chars 2015-12-22 18:46:30,478 Setting DEBUG logging. 2015-12-22 18:46:30,478 attempt 1/10 2015-12-22 18:46:30,478 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d86b3de54ca0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-22 18:46:30,735 unpacking tar archive at: mozilla-inbound-d86b3de54ca0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.536621 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:30.553558) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:30.554175) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:30.565355) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:30.565640) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-22 18:46:30.566090) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-22 18:46:30.566443) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --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', '--system-bits', '64', '--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=928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:46:31 INFO - MultiFileLogger online at 20151222 18:46:31 in /builds/slave/test-pgo 18:46:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:46:31 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:46:31 INFO - {'append_to_log': False, 18:46:31 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:46:31 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:46:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:46:31 INFO - 'branch': 'Mozilla-Inbound', 18:46:31 INFO - 'buildbot_json_path': 'buildprops.json', 18:46:31 INFO - 'config_files': ('talos/linux_config.py',), 18:46:31 INFO - 'default_actions': ('clobber', 18:46:31 INFO - 'read-buildbot-config', 18:46:31 INFO - 'download-and-extract', 18:46:31 INFO - 'populate-webroot', 18:46:31 INFO - 'create-virtualenv', 18:46:31 INFO - 'install', 18:46:31 INFO - 'run-tests'), 18:46:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:46:31 INFO - 'download_minidump_stackwalk': True, 18:46:31 INFO - 'download_symbols': 'ondemand', 18:46:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:46:31 INFO - 'tooltool.py': '/tools/tooltool.py', 18:46:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:46:31 INFO - '/tools/misc-python/virtualenv.py')}, 18:46:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:46:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:46:31 INFO - 'installer_path': 'installer.exe', 18:46:31 INFO - 'log_level': 'info', 18:46:31 INFO - 'log_name': 'talos', 18:46:31 INFO - 'log_to_console': True, 18:46:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:46:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:46:31 INFO - 'opt_config_files': (), 18:46:31 INFO - 'pip_index': False, 18:46:31 INFO - 'sps_profile': False, 18:46:31 INFO - 'sps_profile_interval': 0, 18:46:31 INFO - 'suite': 'dromaeojs-e10s', 18:46:31 INFO - 'system_bits': '64', 18:46:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:46:31 INFO - 'title': 'talos-linux64-ix-012', 18:46:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:46:31 INFO - 'use_talos_json': True, 18:46:31 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:46:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:46:31 INFO - 'work_dir': 'build'} 18:46:31 INFO - ##### 18:46:31 INFO - ##### Running clobber step. 18:46:31 INFO - ##### 18:46:31 INFO - Running pre-action listener: _resource_record_pre_action 18:46:31 INFO - Running main action method: clobber 18:46:31 INFO - rmtree: /builds/slave/test-pgo/build 18:46:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:46:31 INFO - Running post-action listener: _resource_record_post_action 18:46:31 INFO - ##### 18:46:31 INFO - ##### Running read-buildbot-config step. 18:46:31 INFO - ##### 18:46:31 INFO - Running pre-action listener: _resource_record_pre_action 18:46:31 INFO - Running main action method: read_buildbot_config 18:46:31 INFO - Using buildbot properties: 18:46:31 INFO - { 18:46:31 INFO - "project": "", 18:46:31 INFO - "product": "firefox", 18:46:31 INFO - "script_repo_revision": "production", 18:46:31 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 18:46:31 INFO - "repository": "", 18:46:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 18:46:31 INFO - "buildid": "20151222163013", 18:46:31 INFO - "pgo_build": "True", 18:46:31 INFO - "basedir": "/builds/slave/test-pgo", 18:46:31 INFO - "buildnumber": 266, 18:46:31 INFO - "slavename": "talos-linux64-ix-012", 18:46:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:46:31 INFO - "platform": "ubuntu64_hw", 18:46:31 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:46:31 INFO - "branch": "mozilla-inbound", 18:46:31 INFO - "repo_path": "integration/mozilla-inbound", 18:46:31 INFO - "revision": "d86b3de54ca00d1e14ca7b0127dbe8b4d977857d", 18:46:31 INFO - "stage_platform": "linux64-pgo", 18:46:31 INFO - "builduid": "c0e1d3cd11554a6c95bce502346bab2a", 18:46:31 INFO - "slavebuilddir": "test" 18:46:31 INFO - } 18:46:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:46:31 INFO - Running post-action listener: _resource_record_post_action 18:46:31 INFO - ##### 18:46:31 INFO - ##### Running download-and-extract step. 18:46:31 INFO - ##### 18:46:31 INFO - Running pre-action listener: _resource_record_pre_action 18:46:31 INFO - Running main action method: download_and_extract 18:46:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:46:31 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')]} 18:46:31 INFO - https://queue.taskcluster.net/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:46:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/test_packages.json 18:46:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/test_packages.json 18:46:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:46:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:46:33 INFO - Downloaded 1302 bytes. 18:46:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:46:33 INFO - Using the following test package requirements: 18:46:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:46:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:46:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:33 INFO - u'jsshell-linux-x86_64.zip'], 18:46:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:46:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:46:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:46:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:46:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:46:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:46:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:46:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:46:33 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')]} 18:46:33 INFO - https://queue.taskcluster.net/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:46:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/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 18:46:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/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 18:46:35 INFO - Downloaded 23180384 bytes. 18:46:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:46:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:46:36 INFO - Return code: 0 18:46:36 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 18:46: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')]} 18:46:36 INFO - https://queue.taskcluster.net/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:46:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/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 18:46:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/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 18:46:38 INFO - Downloaded 23180384 bytes. 18:46:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:46:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:46:39 INFO - Return code: 0 18:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:39 INFO - https://queue.taskcluster.net/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:46:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:46:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:46:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/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 18:46:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/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 18:46:40 INFO - Downloaded 11132277 bytes. 18:46:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 18:46:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:46:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:46:40 INFO - Return code: 0 18:46:40 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')]} 18:46:40 INFO - https://queue.taskcluster.net/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:46:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:46:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:46:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/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 18:46:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/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 18:46:42 INFO - Downloaded 54841115 bytes. 18:46:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:46:42 INFO - mkdir: /builds/slave/test-pgo/properties 18:46:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:46:42 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:46:42 INFO - Contents: 18:46:42 INFO - build_url:https://queue.taskcluster.net/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:46:42 INFO - Running post-action listener: _resource_record_post_action 18:46:42 INFO - Running post-action listener: set_extra_try_arguments 18:46:42 INFO - ##### 18:46:42 INFO - ##### Running populate-webroot step. 18:46:42 INFO - ##### 18:46:42 INFO - Running pre-action listener: _resource_record_pre_action 18:46:42 INFO - Running main action method: populate_webroot 18:46:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:46:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:46:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:46:42 INFO - '--tppagecycles', 18:46:42 INFO - '7'], 18:46:42 INFO - 'tests': ['tsvgm']}}, 18:46:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:46:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:46:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:46:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:46:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:46:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:46:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:46:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:42 INFO - 'talos_options': ['--e10s'], 18:46:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:46:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:42 INFO - 'tests': ['damp', 'tps']}, 18:46:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:42 INFO - 'talos_options': ['--e10s'], 18:46:42 INFO - 'tests': ['damp', 'tps']}, 18:46:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:46:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:46:42 INFO - 'other': {'tests': ['a11yr', 18:46:42 INFO - 'ts_paint', 18:46:42 INFO - 'tpaint', 18:46:42 INFO - 'sessionrestore', 18:46:42 INFO - 'sessionrestore_no_auto_restore']}, 18:46:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:46:42 INFO - 'tests': ['a11yr', 18:46:42 INFO - 'ts_paint', 18:46:42 INFO - 'tpaint', 18:46:42 INFO - 'sessionrestore', 18:46:42 INFO - 'sessionrestore_no_auto_restore']}, 18:46:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:46:42 INFO - 'tests': ['a11yr', 18:46:42 INFO - 'ts_paint', 18:46:42 INFO - 'tpaint', 18:46:42 INFO - 'sessionrestore', 18:46:42 INFO - 'sessionrestore_no_auto_restore']}, 18:46:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:46:42 INFO - 'tests': ['a11yr', 18:46:42 INFO - 'ts_paint', 18:46:42 INFO - 'tpaint', 18:46:42 INFO - 'sessionrestore', 18:46:42 INFO - 'sessionrestore_no_auto_restore']}, 18:46:42 INFO - 'other_l64': {'tests': ['a11yr', 18:46:42 INFO - 'ts_paint', 18:46:42 INFO - 'tpaint', 18:46:42 INFO - 'sessionrestore', 18:46:42 INFO - 'sessionrestore_no_auto_restore']}, 18:46:42 INFO - 'other_nol64': {'tests': ['a11yr', 18:46:42 INFO - 'ts_paint', 18:46:42 INFO - 'tpaint', 18:46:42 INFO - 'sessionrestore', 18:46:42 INFO - 'sessionrestore_no_auto_restore']}, 18:46:42 INFO - 'svgr': {'tests': ['tsvgx', 18:46:42 INFO - 'tsvgr_opacity', 18:46:42 INFO - 'tart', 18:46:42 INFO - 'tscrollx', 18:46:42 INFO - 'cart']}, 18:46:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:46:42 INFO - 'tests': ['tsvgx', 18:46:42 INFO - 'tsvgr_opacity', 18:46:42 INFO - 'tart', 18:46:42 INFO - 'tscrollx', 18:46:42 INFO - 'cart']}, 18:46:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:42 INFO - 'tests': ['tp5o']}, 18:46:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:42 INFO - 'talos_options': ['--e10s'], 18:46:42 INFO - 'tests': ['tp5o']}, 18:46:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:42 INFO - 'talos_options': ['--xperf_path', 18:46:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:46:42 INFO - 'tests': ['tp5n']}, 18:46:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:42 INFO - 'talos_options': ['--e10s', 18:46:42 INFO - '--xperf_path', 18:46:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:46:42 INFO - 'tests': ['tp5n']}}, 18:46:42 INFO - 'talos.zip': {'path': '', 18:46:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:46:42 INFO - Running post-action listener: _resource_record_post_action 18:46:42 INFO - ##### 18:46:42 INFO - ##### Running create-virtualenv step. 18:46:42 INFO - ##### 18:46:42 INFO - Running pre-action listener: _resource_record_pre_action 18:46:42 INFO - Running main action method: create_virtualenv 18:46:42 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:46:42 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 18:46:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:46:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:46:42 INFO - Using real prefix '/usr' 18:46:42 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:46:42 INFO - Installing distribute.............................................................................................................................................................................................done. 18:46:44 INFO - Installing pip.................done. 18:46:44 INFO - Return code: 0 18:46:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe4bfe01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d07f0>, '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 0x253c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c760>, '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': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', '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 18:46:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 18:46:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 18:46:44 INFO - Using env: {'DISPLAY': ':0', 18:46:44 INFO - 'HOME': '/home/cltbld', 18:46:44 INFO - 'LANG': 'en_US.UTF-8', 18:46:44 INFO - 'LANGUAGE': 'en_US:en', 18:46:44 INFO - 'LOGNAME': 'cltbld', 18:46:44 INFO - 'MAIL': '/var/mail/cltbld', 18:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:44 INFO - 'MOZ_NO_REMOTE': '1', 18:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:44 INFO - 'NO_EM_RESTART': '1', 18:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:44 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:44 INFO - 'SHELL': '/bin/bash', 18:46:44 INFO - 'SHLVL': '1', 18:46:44 INFO - 'TERM': 'linux', 18:46:44 INFO - 'TMOUT': '86400', 18:46:44 INFO - 'USER': 'cltbld', 18:46:44 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', 18:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:44 INFO - '_': '/tools/buildbot/bin/python'} 18:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:46:44 INFO - Cleaning up... 18:46:44 INFO - Return code: 0 18:46:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe4bfe01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d07f0>, '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 0x253c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c760>, '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': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', '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 18:46:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 18:46:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 18:46:44 INFO - Using env: {'DISPLAY': ':0', 18:46:44 INFO - 'HOME': '/home/cltbld', 18:46:44 INFO - 'LANG': 'en_US.UTF-8', 18:46:44 INFO - 'LANGUAGE': 'en_US:en', 18:46:44 INFO - 'LOGNAME': 'cltbld', 18:46:44 INFO - 'MAIL': '/var/mail/cltbld', 18:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:44 INFO - 'MOZ_NO_REMOTE': '1', 18:46:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:44 INFO - 'NO_EM_RESTART': '1', 18:46:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:44 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:44 INFO - 'SHELL': '/bin/bash', 18:46:44 INFO - 'SHLVL': '1', 18:46:44 INFO - 'TERM': 'linux', 18:46:44 INFO - 'TMOUT': '86400', 18:46:44 INFO - 'USER': 'cltbld', 18:46:44 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', 18:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:44 INFO - '_': '/tools/buildbot/bin/python'} 18:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:45 INFO - Downloading/unpacking psutil>=0.7.1 18:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:46 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:46:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:46:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:46:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:46:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:46:46 INFO - Installing collected packages: psutil 18:46:46 INFO - Running setup.py install for psutil 18:46:46 INFO - building 'psutil._psutil_linux' extension 18:46:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:46:47 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 18:46:47 INFO - building 'psutil._psutil_posix' extension 18:46:47 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 18:46:47 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 18:46:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:46:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:46:47 INFO - Successfully installed psutil 18:46:47 INFO - Cleaning up... 18:46:47 INFO - Return code: 0 18:46:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:46:47 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')]} 18:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:47 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')]} 18:46:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:47 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe4bfe01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d07f0>, '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 0x253c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c760>, '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': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', '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 18:46:47 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 18:46:47 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 18:46:47 INFO - Using env: {'DISPLAY': ':0', 18:46:47 INFO - 'HOME': '/home/cltbld', 18:46:47 INFO - 'LANG': 'en_US.UTF-8', 18:46:47 INFO - 'LANGUAGE': 'en_US:en', 18:46:47 INFO - 'LOGNAME': 'cltbld', 18:46:47 INFO - 'MAIL': '/var/mail/cltbld', 18:46:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:47 INFO - 'MOZ_NO_REMOTE': '1', 18:46:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:47 INFO - 'NO_EM_RESTART': '1', 18:46:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:47 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:47 INFO - 'SHELL': '/bin/bash', 18:46:47 INFO - 'SHLVL': '1', 18:46:47 INFO - 'TERM': 'linux', 18:46:47 INFO - 'TMOUT': '86400', 18:46:47 INFO - 'USER': 'cltbld', 18:46:47 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', 18:46:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:47 INFO - '_': '/tools/buildbot/bin/python'} 18:46:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:46:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:46:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:46:49 INFO - Installing collected packages: mozsystemmonitor 18:46:49 INFO - Running setup.py install for mozsystemmonitor 18:46:49 INFO - Successfully installed mozsystemmonitor 18:46:49 INFO - Cleaning up... 18:46:49 INFO - Return code: 0 18:46:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe4bfe01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d07f0>, '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 0x253c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c760>, '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': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', '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 18:46:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 18:46:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 18:46:49 INFO - Using env: {'DISPLAY': ':0', 18:46:49 INFO - 'HOME': '/home/cltbld', 18:46:49 INFO - 'LANG': 'en_US.UTF-8', 18:46:49 INFO - 'LANGUAGE': 'en_US:en', 18:46:49 INFO - 'LOGNAME': 'cltbld', 18:46:49 INFO - 'MAIL': '/var/mail/cltbld', 18:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:49 INFO - 'MOZ_NO_REMOTE': '1', 18:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:49 INFO - 'NO_EM_RESTART': '1', 18:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:49 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:49 INFO - 'SHELL': '/bin/bash', 18:46:49 INFO - 'SHLVL': '1', 18:46:49 INFO - 'TERM': 'linux', 18:46:49 INFO - 'TMOUT': '86400', 18:46:49 INFO - 'USER': 'cltbld', 18:46:49 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', 18:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:49 INFO - '_': '/tools/buildbot/bin/python'} 18:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:49 INFO - Downloading/unpacking blobuploader==1.2.4 18:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:51 INFO - Downloading blobuploader-1.2.4.tar.gz 18:46:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:46:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:46:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:46:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:46:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:52 INFO - Downloading docopt-0.6.1.tar.gz 18:46:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:46:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:46:52 INFO - Installing collected packages: blobuploader, requests, docopt 18:46:52 INFO - Running setup.py install for blobuploader 18:46:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:46:52 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:46:52 INFO - Running setup.py install for requests 18:46:52 INFO - Running setup.py install for docopt 18:46:52 INFO - Successfully installed blobuploader requests docopt 18:46:52 INFO - Cleaning up... 18:46:52 INFO - Return code: 0 18:46:52 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:46:52 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')]} 18:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:52 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')]} 18:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe4bfe01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d07f0>, '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 0x253c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c760>, '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': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', '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 18:46:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 18:46:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --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 18:46:52 INFO - Using env: {'DISPLAY': ':0', 18:46:52 INFO - 'HOME': '/home/cltbld', 18:46:52 INFO - 'LANG': 'en_US.UTF-8', 18:46:52 INFO - 'LANGUAGE': 'en_US:en', 18:46:52 INFO - 'LOGNAME': 'cltbld', 18:46:52 INFO - 'MAIL': '/var/mail/cltbld', 18:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:52 INFO - 'MOZ_NO_REMOTE': '1', 18:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:52 INFO - 'NO_EM_RESTART': '1', 18:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:52 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:52 INFO - 'SHELL': '/bin/bash', 18:46:52 INFO - 'SHLVL': '1', 18:46:52 INFO - 'TERM': 'linux', 18:46:52 INFO - 'TMOUT': '86400', 18:46:52 INFO - 'USER': 'cltbld', 18:46:52 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', 18:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:52 INFO - '_': '/tools/buildbot/bin/python'} 18:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:46:52 INFO - Running setup.py (path:/tmp/pip-MWA5l5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:46:53 INFO - Running setup.py (path:/tmp/pip-vfpgUs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:46:53 INFO - Running setup.py (path:/tmp/pip-hIcCGN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:46:53 INFO - Running setup.py (path:/tmp/pip-r94veD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:46:53 INFO - Running setup.py (path:/tmp/pip-U064Jm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:46:53 INFO - Running setup.py (path:/tmp/pip-oUgci6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:46:53 INFO - Running setup.py (path:/tmp/pip-v0koQQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:46:53 INFO - Running setup.py (path:/tmp/pip-9eoo3r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:46:53 INFO - Running setup.py (path:/tmp/pip-d4QTAt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:46:53 INFO - Running setup.py (path:/tmp/pip-QHTYgM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:46:53 INFO - Running setup.py (path:/tmp/pip-MP7MD5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:46:53 INFO - Running setup.py (path:/tmp/pip-Q7xb_8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:46:53 INFO - Running setup.py (path:/tmp/pip-rQE0RJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:46:53 INFO - Running setup.py (path:/tmp/pip-XXTNI5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:46:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:46:53 INFO - Running setup.py (path:/tmp/pip-nhzttT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:46:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:46:54 INFO - Running setup.py (path:/tmp/pip-zV72OZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:46:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:46:54 INFO - Running setup.py (path:/tmp/pip-MJMSUp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:46:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:46:54 INFO - Running setup.py install for manifestparser 18:46:54 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:46:54 INFO - Running setup.py install for mozcrash 18:46:54 INFO - Running setup.py install for mozdebug 18:46:54 INFO - Running setup.py install for mozdevice 18:46:54 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:46:54 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:46:54 INFO - Running setup.py install for mozfile 18:46:54 INFO - Running setup.py install for mozhttpd 18:46:54 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:46:54 INFO - Running setup.py install for mozinfo 18:46:54 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:46:54 INFO - Running setup.py install for mozInstall 18:46:54 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:46:54 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:46:54 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:46:54 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:46:54 INFO - Running setup.py install for mozleak 18:46:55 INFO - Running setup.py install for mozlog 18:46:55 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:46:55 INFO - Running setup.py install for moznetwork 18:46:55 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:46:55 INFO - Running setup.py install for mozprocess 18:46:55 INFO - Running setup.py install for mozprofile 18:46:55 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:46:55 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:46:55 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:46:55 INFO - Running setup.py install for mozrunner 18:46:55 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:46:55 INFO - Running setup.py install for mozscreenshot 18:46:55 INFO - Running setup.py install for moztest 18:46:55 INFO - Running setup.py install for mozversion 18:46:55 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:46:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:46:55 INFO - Cleaning up... 18:46:55 INFO - Return code: 0 18:46:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:46:55 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')]} 18:46:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:55 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')]} 18:46:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe4bfe01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d07f0>, '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 0x253c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c760>, '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': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', '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 18:46:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 18:46:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 18:46:55 INFO - Using env: {'DISPLAY': ':0', 18:46:55 INFO - 'HOME': '/home/cltbld', 18:46:55 INFO - 'LANG': 'en_US.UTF-8', 18:46:55 INFO - 'LANGUAGE': 'en_US:en', 18:46:55 INFO - 'LOGNAME': 'cltbld', 18:46:55 INFO - 'MAIL': '/var/mail/cltbld', 18:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:55 INFO - 'MOZ_NO_REMOTE': '1', 18:46:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:55 INFO - 'NO_EM_RESTART': '1', 18:46:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:55 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:55 INFO - 'SHELL': '/bin/bash', 18:46:55 INFO - 'SHLVL': '1', 18:46:55 INFO - 'TERM': 'linux', 18:46:55 INFO - 'TMOUT': '86400', 18:46:55 INFO - 'USER': 'cltbld', 18:46:55 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', 18:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:55 INFO - '_': '/tools/buildbot/bin/python'} 18:46:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:46:56 INFO - Running setup.py (path:/tmp/pip-ECUKOI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:46:56 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)) 18:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:46:56 INFO - Running setup.py (path:/tmp/pip-hcP9xV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:46:56 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)) 18:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:46:56 INFO - Running setup.py (path:/tmp/pip-773IDp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:46:56 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)) 18:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:46:56 INFO - Running setup.py (path:/tmp/pip-FPLDvW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 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)) 18:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:46:56 INFO - Running setup.py (path:/tmp/pip-Zegwil-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:46:56 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)) 18:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:46:56 INFO - Running setup.py (path:/tmp/pip-pu0MYr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:46:56 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)) 18:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:46:56 INFO - Running setup.py (path:/tmp/pip-dfobZG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:46:56 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)) 18:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:46:56 INFO - Running setup.py (path:/tmp/pip-oNQYFj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:46:56 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)) 18:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:46:56 INFO - Running setup.py (path:/tmp/pip-xhd6HO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:46:56 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)) 18:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:46:56 INFO - Running setup.py (path:/tmp/pip-jzuywL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:46:56 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)) 18:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:46:56 INFO - Running setup.py (path:/tmp/pip-zKK6wp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:46:56 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)) 18:46:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:46:56 INFO - Running setup.py (path:/tmp/pip-UGJgq_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:46:57 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)) 18:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:46:57 INFO - Running setup.py (path:/tmp/pip-qwcYhY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:46:57 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)) 18:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:46:57 INFO - Running setup.py (path:/tmp/pip-P2Ci_B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:46:57 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)) 18:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:46:57 INFO - Running setup.py (path:/tmp/pip-WkuH4X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:46:57 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)) 18:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:46:57 INFO - Running setup.py (path:/tmp/pip-irYuZK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:46:57 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)) 18:46:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:46:57 INFO - Running setup.py (path:/tmp/pip-6zan44-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:46:57 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)) 18:46:57 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)) 18:46:57 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)) 18:46:57 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)) 18:46:57 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:46:57 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.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:46:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:46:57 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 18:46:57 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 18:46:57 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 18:46:57 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 18:46:57 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 18:46:57 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 18:46:59 INFO - Downloading blessings-1.5.1.tar.gz 18:46:59 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 18:46:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:46:59 INFO - Installing collected packages: blessings 18:46:59 INFO - Running setup.py install for blessings 18:46:59 INFO - Successfully installed blessings 18:46:59 INFO - Cleaning up... 18:46:59 INFO - Return code: 0 18:46:59 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:46:59 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:46:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:46:59 INFO - Reading from file tmpfile_stdout 18:46:59 INFO - Current package versions: 18:46:59 INFO - argparse == 1.2.1 18:46:59 INFO - blessings == 1.5.1 18:46:59 INFO - blobuploader == 1.2.4 18:46:59 INFO - docopt == 0.6.1 18:46:59 INFO - manifestparser == 1.1 18:46:59 INFO - mozInstall == 1.12 18:46:59 INFO - mozcrash == 0.16 18:46:59 INFO - mozdebug == 0.1 18:46:59 INFO - mozdevice == 0.47 18:46:59 INFO - mozfile == 1.2 18:46:59 INFO - mozhttpd == 0.7 18:46:59 INFO - mozinfo == 0.9 18:46:59 INFO - mozleak == 0.1 18:46:59 INFO - mozlog == 3.1 18:46:59 INFO - moznetwork == 0.27 18:46:59 INFO - mozprocess == 0.22 18:46:59 INFO - mozprofile == 0.28 18:46:59 INFO - mozrunner == 6.11 18:46:59 INFO - mozscreenshot == 0.1 18:46:59 INFO - mozsystemmonitor == 0.0 18:46:59 INFO - moztest == 0.7 18:46:59 INFO - mozversion == 1.4 18:46:59 INFO - psutil == 3.1.1 18:46:59 INFO - requests == 1.2.3 18:46:59 INFO - wsgiref == 0.1.2 18:46:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe4bfe01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d07f0>, '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 0x253c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c760>, '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': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', '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 18:46:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 18:46:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 18:46:59 INFO - Using env: {'DISPLAY': ':0', 18:46:59 INFO - 'HOME': '/home/cltbld', 18:46:59 INFO - 'LANG': 'en_US.UTF-8', 18:46:59 INFO - 'LANGUAGE': 'en_US:en', 18:46:59 INFO - 'LOGNAME': 'cltbld', 18:46:59 INFO - 'MAIL': '/var/mail/cltbld', 18:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:59 INFO - 'MOZ_NO_REMOTE': '1', 18:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:59 INFO - 'NO_EM_RESTART': '1', 18:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:59 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:59 INFO - 'SHELL': '/bin/bash', 18:46:59 INFO - 'SHLVL': '1', 18:46:59 INFO - 'TERM': 'linux', 18:46:59 INFO - 'TMOUT': '86400', 18:46:59 INFO - 'USER': 'cltbld', 18:46:59 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', 18:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:59 INFO - '_': '/tools/buildbot/bin/python'} 18:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:59 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)) 18:46:59 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)) 18:46:59 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)) 18:46:59 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)) 18:46:59 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)) 18:46:59 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)) 18:46:59 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)) 18:46:59 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)) 18:46:59 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)) 18:46:59 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)) 18:46:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:46:59 INFO - Cleaning up... 18:46:59 INFO - Return code: 0 18:46:59 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe4bfe01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d07f0>, '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 0x253c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c760>, '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': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', '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 18:46:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 18:46:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 18:46:59 INFO - Using env: {'DISPLAY': ':0', 18:46:59 INFO - 'HOME': '/home/cltbld', 18:46:59 INFO - 'LANG': 'en_US.UTF-8', 18:46:59 INFO - 'LANGUAGE': 'en_US:en', 18:46:59 INFO - 'LOGNAME': 'cltbld', 18:46:59 INFO - 'MAIL': '/var/mail/cltbld', 18:46:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:59 INFO - 'MOZ_NO_REMOTE': '1', 18:46:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:59 INFO - 'NO_EM_RESTART': '1', 18:46:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:59 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:59 INFO - 'SHELL': '/bin/bash', 18:46:59 INFO - 'SHLVL': '1', 18:46:59 INFO - 'TERM': 'linux', 18:46:59 INFO - 'TMOUT': '86400', 18:46:59 INFO - 'USER': 'cltbld', 18:46:59 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', 18:46:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:59 INFO - '_': '/tools/buildbot/bin/python'} 18:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:59 INFO - Downloading/unpacking jsonschema 18:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:47:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 18:47:01 INFO - Downloading/unpacking functools32 (from jsonschema) 18:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:01 INFO - Downloading functools32-3.2.3-2.tar.gz 18:47:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:47:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:47:01 INFO - warning: no files found matching '*.txt' 18:47:01 INFO - no previously-included directories found matching 'build' 18:47:01 INFO - no previously-included directories found matching 'dist' 18:47:01 INFO - no previously-included directories found matching '.git*' 18:47:01 INFO - Installing collected packages: jsonschema, functools32 18:47:01 INFO - Running setup.py install for functools32 18:47:02 INFO - warning: no files found matching '*.txt' 18:47:02 INFO - no previously-included directories found matching 'build' 18:47:02 INFO - no previously-included directories found matching 'dist' 18:47:02 INFO - no previously-included directories found matching '.git*' 18:47:02 INFO - Successfully installed jsonschema functools32 18:47:02 INFO - Cleaning up... 18:47:02 INFO - Return code: 0 18:47:02 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:47:02 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')]} 18:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:02 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')]} 18:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 0x7fe4bfe01f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x246f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x253e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25d07f0>, '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 0x253c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c760>, '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': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', '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 18:47:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--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 18:47:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --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 18:47:02 INFO - Using env: {'DISPLAY': ':0', 18:47:02 INFO - 'HOME': '/home/cltbld', 18:47:02 INFO - 'LANG': 'en_US.UTF-8', 18:47:02 INFO - 'LANGUAGE': 'en_US:en', 18:47:02 INFO - 'LOGNAME': 'cltbld', 18:47:02 INFO - 'MAIL': '/var/mail/cltbld', 18:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:02 INFO - 'MOZ_NO_REMOTE': '1', 18:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:02 INFO - 'NO_EM_RESTART': '1', 18:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:02 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:02 INFO - 'SHELL': '/bin/bash', 18:47:02 INFO - 'SHLVL': '1', 18:47:02 INFO - 'TERM': 'linux', 18:47:02 INFO - 'TMOUT': '86400', 18:47:02 INFO - 'USER': 'cltbld', 18:47:02 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', 18:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:02 INFO - '_': '/tools/buildbot/bin/python'} 18:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:02 INFO - Downloading/unpacking flake8 18:47:02 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 18:47:02 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 18:47:02 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 18:47:02 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 18:47:02 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 18:47:02 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 18:47:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:47:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 18:47:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:47:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 18:47:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 18:47:04 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:47:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:47:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:47:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:47:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:47:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:47:04 INFO - no previously-included directories found matching 'docs/_build' 18:47:04 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:47:04 INFO - Running setup.py install for pep8 18:47:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:47:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:47:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:47:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:47:04 INFO - no previously-included directories found matching 'docs/_build' 18:47:04 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:47:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:47:04 INFO - Cleaning up... 18:47:04 INFO - Return code: 0 18:47:04 INFO - Running post-action listener: _resource_record_post_action 18:47:04 INFO - Running post-action listener: _start_resource_monitoring 18:47:04 INFO - Starting resource monitoring. 18:47:04 INFO - ##### 18:47:04 INFO - ##### Running install step. 18:47:04 INFO - ##### 18:47:04 INFO - Running pre-action listener: _resource_record_pre_action 18:47:04 INFO - Running main action method: install 18:47:04 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:47:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:47:05 INFO - Reading from file tmpfile_stdout 18:47:05 INFO - Detecting whether we're running mozinstall >=1.0... 18:47:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:47:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:47:05 INFO - Reading from file tmpfile_stdout 18:47:05 INFO - Output received: 18:47:05 INFO - Usage: mozinstall [options] installer 18:47:05 INFO - Options: 18:47:05 INFO - -h, --help show this help message and exit 18:47:05 INFO - -d DEST, --destination=DEST 18:47:05 INFO - Directory to install application into. [default: 18:47:05 INFO - "/builds/slave/test-pgo"] 18:47:05 INFO - --app=APP Application being installed. [default: firefox] 18:47:05 INFO - mkdir: /builds/slave/test-pgo/build/application 18:47:05 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'] 18:47:05 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 18:47:21 INFO - Reading from file tmpfile_stdout 18:47:21 INFO - Output received: 18:47:21 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:47:21 INFO - Running post-action listener: _resource_record_post_action 18:47:21 INFO - ##### 18:47:21 INFO - ##### Running run-tests step. 18:47:21 INFO - ##### 18:47:21 INFO - Running pre-action listener: _resource_record_pre_action 18:47:21 INFO - Running main action method: run_tests 18:47:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:47:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:47:21 INFO - Python 2.7.3 18:47:21 INFO - Return code: 0 18:47:21 INFO - grabbing minidump binary from tooltool 18:47: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')]} 18:47:21 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 0x25d07f0>, '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 0x253c2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x253c760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:47:21 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 18:47:21 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 18:47:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:47:21 INFO - Return code: 0 18:47:21 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:47:21 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:47:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:47:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:47:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:47:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:47:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:47:22 INFO - Return code: 0 18:47:22 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/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 18:47:22 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/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 18:47:22 INFO - Using env: {'DISPLAY': ':0', 18:47:22 INFO - 'HOME': '/home/cltbld', 18:47:22 INFO - 'LANG': 'en_US.UTF-8', 18:47:22 INFO - 'LANGUAGE': 'en_US:en', 18:47:22 INFO - 'LOGNAME': 'cltbld', 18:47:22 INFO - 'MAIL': '/var/mail/cltbld', 18:47:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:47:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:47:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:22 INFO - 'MOZ_NO_REMOTE': '1', 18:47:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:47:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:22 INFO - 'NO_EM_RESTART': '1', 18:47:22 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:22 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:22 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:47:22 INFO - 'SHELL': '/bin/bash', 18:47:22 INFO - 'SHLVL': '1', 18:47:22 INFO - 'TERM': 'linux', 18:47:22 INFO - 'TMOUT': '86400', 18:47:22 INFO - 'USER': 'cltbld', 18:47:22 INFO - 'XDG_SESSION_COOKIE': '928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753', 18:47:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:22 INFO - '_': '/tools/buildbot/bin/python'} 18:47:22 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/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 18:47:22 INFO - mozversion application_buildid: 20151222163013 18:47:22 INFO - mozversion application_changeset: d86b3de54ca00d1e14ca7b0127dbe8b4d977857d 18:47:22 INFO - mozversion application_display_name: Nightly 18:47:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:47:22 INFO - mozversion application_name: Firefox 18:47:22 INFO - mozversion application_remotingname: firefox 18:47:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:47:22 INFO - mozversion application_vendor: Mozilla 18:47:22 INFO - mozversion application_version: 46.0a1 18:47:22 INFO - mozversion platform_buildid: 20151222163013 18:47:22 INFO - mozversion platform_changeset: d86b3de54ca00d1e14ca7b0127dbe8b4d977857d 18:47:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:47:22 INFO - mozversion platform_version: 46.0a1 18:47:22 INFO - using testdate: 1450838842 18:47:22 INFO - actual date: 1450838842 18:47:22 INFO - starting webserver on 'localhost:36106' 18:47:22 INFO - SUITE-START | Running 3 tests 18:47:22 INFO - TEST-START | dromaeo_css 18:47:22 INFO - operating with platform_type : linux_ 18:47:22 INFO - Initialising browser for dromaeo_css test... 18:47:22 INFO - TEST-INFO | started process 2804 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIAbe8H/profile http://localhost:36106/getInfo.html) 18:47:26 INFO - PROCESS | 2804 | __metrics Screen width/height:1600/1200 18:47:26 INFO - PROCESS | 2804 | colorDepth:24 18:47:26 INFO - PROCESS | 2804 | Browser inner width/height: 1024/697 18:47:26 INFO - PROCESS | 2804 | __metrics 18:47:26 INFO - PROCESS | 2804 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:47:27 INFO - TEST-INFO | 2804: exit 0 18:47:27 INFO - Browser initialized. 18:47:27 INFO - Running cycle 1/1 for dromaeo_css test... 18:47:27 INFO - TEST-INFO | started process 3016 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIAbe8H/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:47:39 INFO - PROCESS | 3016 | RSS: Main: 151322624 18:47:39 INFO - PROCESS | 3016 | 18:48:28 INFO - PROCESS | 3016 | 1450838908884 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] 18:50:37 INFO - PROCESS | 3016 | Cycle 1(1): loaded http://localhost:36106/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36106/tests/dromaeo/cssquery-ext.html) 18:50:38 INFO - PROCESS | 3016 | RSS: Main: 157904896 18:50:38 INFO - PROCESS | 3016 | 18:53:40 INFO - PROCESS | 3016 | Cycle 1(1): loaded http://localhost:36106/tests/dromaeo/cssquery-ext.html (next: http://localhost:36106/tests/dromaeo/cssquery-jquery.html) 18:53:41 INFO - PROCESS | 3016 | RSS: Main: 152248320 18:53:41 INFO - PROCESS | 3016 | 18:56:43 INFO - PROCESS | 3016 | Cycle 1(1): loaded http://localhost:36106/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36106/tests/dromaeo/cssquery-mootools.html) 18:56:43 INFO - PROCESS | 3016 | RSS: Main: 152952832 18:56:43 INFO - PROCESS | 3016 | 18:59:45 INFO - PROCESS | 3016 | Cycle 1(1): loaded http://localhost:36106/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36106/tests/dromaeo/cssquery-prototype.html) 18:59:46 INFO - PROCESS | 3016 | RSS: Main: 152117248 18:59:46 INFO - PROCESS | 3016 | 19:02:48 INFO - PROCESS | 3016 | Cycle 1(1): loaded http://localhost:36106/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36106/tests/dromaeo/cssquery-yui.html) 19:02:48 INFO - PROCESS | 3016 | RSS: Main: 152952832 19:02:48 INFO - PROCESS | 3016 | 19:05:51 INFO - PROCESS | 3016 | Cycle 1(1): loaded http://localhost:36106/tests/dromaeo/cssquery-yui.html (next: http://localhost:36106/tests/dromaeo/cssquery-dojo.html) 19:05:51 INFO - PROCESS | 3016 | RSS: Main: 154914816 19:05:51 INFO - PROCESS | 3016 | 19:05:51 INFO - PROCESS | 3016 | __start_tp_report 19:05:51 INFO - PROCESS | 3016 | _x_x_mozilla_page_load 19:05:51 INFO - PROCESS | 3016 | _x_x_mozilla_page_load_details 19:05:51 INFO - PROCESS | 3016 | |i|pagename|runs| 19:05:51 INFO - PROCESS | 3016 | |0;dojo.html;3195.7762956593033;3238.0609623209284;3248.837558122096;3266.983665081674;3278.7049165575095;5182.559482443988;5331.920021199685;5385.623006389555;5389.110796718542;5390.649607775496;5219.9478005219935;5297.364316282052;5301.549368303689;5328.387235467912;5337.6797392156495;4849.418069831608;4915.188993816016;4929.728864912428;4967;4986.326845875815;4844.055409195208;4933.654644174909;4935.259711043336;4940.481249468808;4968.677035992667;4807.807687692488;4867.70793752376;4959.876003099934;4993.151164302041;5030.748462576893;4865.464798872121;4890.486498917598;4907.852764417074;4908.77910494025;4953.108440480712;4754.215554433515;4851.611871050308;4892.68197567157;4894.681845680019;4926.679765815246;5098.133317336062;5135.820246291362;5165.483451654842;5176.870578235536;5238.947610523884;5733;5745.683987380692;5751.913721294142;5757.280339957505;5786.276715410574;5685.374608793029;5793.102069179284;5806.129080637938;5807.738651760681;5821.330546987108;5167.48325167484;5179.689218646856;5217.713025783581;5221.164613661834;5233.241180028951;5784.2769653793275;5787.363390027093;5791.536677065825;5792.913106303409;5833.50415214703;5583.832485025375;5614.045612245928;5644.604877658525;5708.400617935057;5710.200571919934;5735.283089613798;5779.711014449261;5816.272965879265;5818.592698511064;5821.534277257894;5705.229793977843;5746.827595172152;5785.913211301834;5795.130730390475;5795.275590551181;5759.337676167211;5799.565032622486;5806.042003069446;5815.534757219412;5851.151583020438;4463.575960283768;4475.552444755564;4477.395551600557;4483.21543729846;4525.366448697185;3928.332183528807;3951.2295102454746;3993.800309984489;4018.1561872006623;4055.959440405617;5362.088444964365;5373.462653734595;5386.946130538723;5391.676499410048;5405.189221616711;5742.052561327418;5762.193292938992;5765.279340082489;5785.595008349375;5789.652620842763;5128.512791284822;5231.346081739783;5313.388960269541;5340.172273297645;5431.918521222185;4866.270059491105;4881.316615673809;4894.461609222983;4903.509649035068;4928.950710492921;5903.0555111182;5924.6149000314845;5941.079132734347;5948.256467941507;5964.165016897551;5717.685527295872;5823.505002074871;5827.038538641077;5905.291365036223;5922.230110085661;5959.642421454727;5986.102084687332;6005.429484198994;6009.609375390585;6017.909731354121;5502.58730595199;5721.485066344049;5728.684922329312;5733.31200255972;5754.856128596819;5725.312962444534;5773.134029895549;5860.150278209721;5905.881882362414;5907.9704601476715;5722.856928576819;5739.512141468022;5742.08126699726;5744.109663002241;5746.770129194785;5613.326400831763;5645.322561292507;5687.5449964001955;5699.544036476989;5699.601027928005;5500.50495455395;5513.8345849624575;5514.944850551604;5557.833265002057;5595.160725891149;5621.184928185472;5653.434656534479;5663.716814159358;5692.459216374438;5694.544436445157;5356.839294821161;5441.83674489766;5537.36320323168;5550.056490396723;5564.165375193753 19:05:51 INFO - PROCESS | 3016 | |1;ext.html;568.3631142310146;586.5835256967553;606.6329870428391;615.1756646094234;617.9155581953671;29493.852530737342;37002;37448.99999999996;37626.0593485163;37676;41292.17415651693;41739.16521669565;41997.58002419975;42064;42159.36760948588;8631.43895646784;8751.037385887546;8829.646814127427;8873.3344999125;8885.68900088497;8647.394682372236;8675.08911564286;8721.084286149959;8740.606672699712;8750.518721470316;8591.914080859175;8736.8689469658;8771.166739159802;8771.605277762515;8771.692990745325;8694.652213911437;8721.651133954634;8728.25809806164;8746.737597872074;8780.604872780708;8541.658333666646;8675.479471231747;8685.261752751023;8720.563971801448;8721.12788721129;39634.60365396338;39807;39906.20187596232;39935.201295974206;40042.399364009565;3353.4131526982924;3528.929421411583;3704.240630670733;3796.14586717989;4026.355783074694;29017;29098.41803163946;29918.70081299181;30106.54840177399;30562.847185764153;3933;3947.50656167979;3997.8400863965408;4046.4941882264716;4114.177164567069;267356;268143;268248;268271;268959;49505.25742113799;54543.72728136413;54807.451925480236;55151;55184.44815551873;44050.33924491135;58811.411885880596;59606.70196649076;59798.40201598015;59811.700941495015;13642.454301828015;13885.236312002937;13893.79159312611;13900.374483148282;13910.165390076629;10675.359478431164;10700.94649526763;10702.464876756287;10752.516136773864;10773.946130269454;17846.375376861746;18552.350667726565;18692.34576789806;18692.813071869106;18709.532261693566;7859.205884410505;7992.5204487730925;8042.638081286239;8060.153683863227;8060.193980601893;843.8734189871568;845.0366582096415;936.7704912296394;994.5014589991528;1078.0297732041226;26190;26792.19623411301;26894.193174204804;27706.584401234;29007.41985160285;954.6658669465631;997.5162046407487;1005.2711783956719;1074.425182527344;1150.2121047082608;13554.864451355557;13839.861601384058;13871.583852484442;13949.511767088306;15228.923855380874;241684;243865;244999;245960;246867;46877.29684054742;47505.28742068803;47635;47660.28509572359;47689.28466073012;1322.3454390076781;1351.1892864281353;1355.2342926246442;1364.0724307471014;1369.760291948925;27668.723312766615;28480.43039139247;28764.137075887757;28832.567511487763;28863.42273154567;45104.548954510035;45119.32321015253;45179;45335.31997019982;45465;295233;297075;297951;298092;298205;30027.249318767204;30165.245868853453;30345.39309213759;30467.17196968189;30481.695183048774;40383;41189.79405102955;41716.374254386814;42091.7895410521;42283.15433691248;34579.82710086534;35184.64815351814;35285.56345743902;35405.82297088498;35838.820805895804;35024.64975350316;35204;35325.64674353327;35385.82307088448;35419;34690.82654586711;35081.82459087688;35188.82405587956;35231.47152792659;35640.4653930186;31216.843915780275;31310.217244568157;31594.842025790644;32106.839465803456;32307;24062;32207.677923220468;33867.322653546296;33984.830075849466;34142.14644633805 19:05:51 INFO - PROCESS | 3016 | |2;jquery.html;352.7636483556018;358.3084646631999;358.89950813772145;360.96209897960716;360.96403322464533;16509.752353714688;17107.486775396726;17549.824501754978;17930.73103903441;18265.178066986984;10352.327098738595;10765.730856728585;14291.285435728223;14332.713345733078;14340.713185736306;4882.926756098653;5008.474110218429;5197.454267301936;5378.704171270579;5391.083515802323;4425.579569940866;5326.493983071602;5339.038972984861;5367.141257398817;5370.570354371641;5619.662820230778;5629.774809007635;6600.93399066008;6859.07402500661;6862;6687.331266873322;6796.150481189851;6805.829854253634;6836.521443498982;6839.794806155824;6644.66776661165;6648.734050637969;6648.867022659568;6654.633995130266;6661.233958094785;22090.77909220903;22743.772562274495;23229.186978455673;23309.067637294487;23339.76660233393;2243.551289742058;2299.1148407862925;2323.2913961241816;2348.7064116985375;2361.622140457536;13958.232297223649;14157.292135393189;14299.356528956117;14457.927710361486;14903.701925961528;1869.6821540338176;1885.27416944476;1928.4021953194554;1966.3314473079222;1977.2881762565464;65115.3488465114;68531.65734171346;68846;68913.65543172252;71140.6442967787;14957.606782914681;15149.318280677397;15456.768148477782;15480.922595386952;15484.845151548565;24457.633135502983;24467.87766061194;24475.632865507032;24664.753352466603;24707.135250266154;8582.613782379807;8592.398532102692;8613.44012639189;8682.175193356621;8880.911190888137;7234.421246300283;7303.8539229216185;7323.523970941872;7351.669174887143;7375.37309328713;7644;7663.770086897402;7676;7773.106092799288;7904.249096335839;1832.4777438429983;2915.985420072886;3121.8907338243052;3122.3755248949847;3128.3856311940162;407.8225971702319;411.2043196414947;411.48358809693644;796.5738329993426;922.1193759959223;10862.293950893325;11041.282316649553;11197.776044479066;11276.548938042386;16715.582110447336;861.3238607692931;862.0904945282787;942.6936245720168;974.133021610767;977.9266555008403;6572.901406478906;9828.606855725833;9865.1121399073;9964.10323070927;9974.700758977242;526873;534282;537776;543746;554751;80123;81371.5931420339;83248.58375708204;83384.16615833764;83814.48556543313;1148.1102145836876;1153.7288737146764;1190.8273300371397;1192.167459789194;1193.146899966528;15521.728921771723;15573.922130389275;15688.529344119695;15818.841811582197;15940.442084526985;35221.82389088038;35351.11622209465;35386.46920296249;35441.29117417689;35570.822145889106;42007;43040.56959430491;43260.783696081315;43736.343954840064;44470.555294447935;9299.953500232727;9673.274504412339;9720.125188733047;9772.706818795448;9807.85288220663;11485;16816.663666726843;16915.492535223962;17454.91272543629;17699;13123.475060997453;13196.538121165713;13683.384247708678;13702.931485342908;13712.314384280946;14427.42290308376;14507;14536.781948270573;14773;14989.175595342362;13914.582562523141;13966.930165349107;14133.6466588332;14246.643833904236;14592.489262875748;9580.760480987752;9670.806583868423;9713.70858874235;9738.756531086496;9865.506724663881;10073.143782778547;11984.340861252365;13771.655708607364;14175.432982680577;14392.928035360175 19:05:51 INFO - PROCESS | 3016 | |3;mootools.html;1424.6295963049606;1483.4437086092719;1594.7368684167113;1602.4311369463846;1723.1728770190316;6661.933380666192;6777.017332486799;6805.523613347068;7156.713731450743;7210.170830354505;7065.399441047517;7205.207427183006;7226.060612120417;7269.5638261704335;7323.853522929551;2171.1206961180706;2206.073449151352;2214.22502124256;2218.9889050554725;2221.988995007268;2221.2336743823357;2226.4545186429345;2292.151903795598;2310.4685922237895;2317.177402022283;2225.6868447615902;2226.92205772798;2241.7758224177614;2255.1994042115057;2280.9657855132186;2207.227470385368;2226.8886555672234;2233.140241007208;2237.820974322067;2249;2251.909923603054;2280.338701776483;2285.8285628577923;2289.828262880274;2294.724633044029;7276.308750668678;7284.6721897514735;7292.781216563459;7311.963440182818;7390.963045184793;4376.540463251376;4417.602415782563;4428.247197976351;4441.156180325728;4445.777711114431;3010.473167195754;3037.39252149571;3093.474109401407;3123.9843800781077;3129.8278594677286;1006.9144122749575;1011.2567263061644;1031.9845202321972;1035.321864178964;1039.8856125826153;9710.417374957455;9785.363951343212;9799.853002204973;9815.263855210816;9824.65613703517;4045.474088368552;4058.452108965311;4080.3879418087527;4093.4678491795876;4103.138340948374;8488.74533763988;8546.487210767375;8547.145285471528;8554.957225213833;8555.743327700178;4448.243798554254;4471.06107717383;4477.888052798641;4486.977565112219;4488.483824360241;3911.5501717302304;3972.1459886124044;4014.6186112319283;4027.5368332641533;4045.8988525287104;3543.6102028776813;3568;3580.15866271426;3594.0475773919934;3624.8006359649944;1132.399828091113;1139.4986206069302;1140.293018328625;1142;1145.450183911727;975.7316737897135;978.1392374710209;982.832918403873;1107.2360071550604;1357.4027427931678;6752.257251702309;6772.187337519431;6787.966060169668;6826.8634627308165;6840.6921688524135;490.37966971780725;504.84602196329735;512.6975084700044;515.2091539486945;516.8320295903846;5533.253010843565;5547.694876781735;5550.028744969614;5590.8043218487155;5595.244641973363;7884.21157884207;8026.036875574969;8119.106898241189;8380.287675547646;8491.405601607828;8452.535110568977;8515.105913878953;8529.74410767678;8552.486850788848;8563.229309362187;6715.865682686319;6775.525713200029;6784.08414863987;6789.321067893171;6854.760083397157;7009.824754381181;7031;7069.151701795818;7073.71705131789;7103.964480177773;7439.256074392518;7532.209118042527;7548.433867460072;7637.083549974039;7813.804654883674;7794.493357931717;7915.722949696733;7985.5208687478935;7987.680492780224;7994.200579941959;6416.262129855127;6608.801735947929;6611.735530578723;6641.435477984425;6681.231658359156;7070.540414873017;7105.644717764195;7114.288571142844;7141.535800172972;7176.928230717835;6497.772577959938;6619;6700.296468870698;6766.255711871789;6787.490938179558;6470.611763294218;6533.509986751108;6661.367170118831;6734.797956061326;6794.728210871707;6610.272869984202;6615.801525954229;6638.5684930479365;6645.734170633121;6649.501287403561;5981.551383646157;6138.171346868295;6144.477719393902;6151.954167791576;6156.507479401726;6292.685365731787;6299.527535434769;6328;6356.141920840627;6365.204349456318 19:05:51 INFO - PROCESS | 3016 | |4;prototype.html;334.6502904464834;336.1461886807509;338.41285369883235;344.11219054838534;346.27109933589793;6346.14327065846;6357.1417858589075;6390.5207109466855;6424.2290925089055;6506.934930650692;6341.746330146801;6406;6416.454601358879;6429.260635026973;6429.774957876475;4827.806887724496;4829.299751536025;4858.149823780842;4861.951380486203;4874.926876096862;4869.050535145648;4875.049365373754;4879.146149423855;4882.926756098661;4890.3642526471685;4611.976940115312;4615.561521655454;4686.882827929312;4688.5545873142;4738.218193997986;4662.673612847102;4667.6265898728025;4679.976600116977;4682.6019788318035;4691.8504966283135;4074;4090.4886889138857;4097.262492751303;4100.384942258685;4103.425520427142;5951.107333899907;5954.047352423591;5957.791477298274;5966.0454327307425;5970.537218381524;5412.675239485643;5432.809851655213;5487.094629386146;5496.1755736639425;5501.889962200774;6569.178852643419;6604.3725846044545;6608.537402381835;6618.834529136762;6619.278987463246;4500.5274446183;4500.752458614775;4506.684532082755;4508.368828364031;4510.909781804346;6970.093887794555;7047.8590428191665;7096.396806271473;7107.857842843166;7126.251743566902;4650.906981860344;4682.9765851171205;4701.036287561042;4703;4704.811807527729;4723.6929599575915;4755.072760811678;4761.928571071437;4763.523647635278;4768.690035147773;5546.168074788814;5554.833354999357;5557.944420555824;5560.7219639017885;5570.136628822539;6695.799126026227;6700.162479690039;6811.693473793691;6813.693383797741;6819.045333653293;1659.983400166007;1675.852041351678;1680.0423758457562;1680.7646929429889;1683.8316168383064;1104.9502772375263;1111.0722546673458;1114.587602587048;1125.054953838763;1128.610629332879;6428.967855160694;6441.967790161019;6449.709763060673;6457.354264573599;6459.5143117083335;7017.543859649107;7019.613921234381;7022.508424410345;7024.754133605299;7033.8241543960785;6368.172137622172;6372.7132279047555;6420.261669907927;6532.771353002717;6534.346565343428;3822.57951625321;3843.3082045231567;3853.344931361675;3855.383138697795;3858.3247931611854;7409;7415.480916335805;7418.035655364876;7437.367823735043;7447.478676492594;7103.934409838462;7275.854482910312;7289.307515785992;7290.9635451822405;7305.561666300039;7336.5231259969;7361.889571656429;7367.410607151415;7373.410127189812;7388.815279617945;6948.722051117898;7067.681954312171;7081.752138675121;7086.858262834818;7091.893621595784;6979.092717946634;7016.087908571853;7017.333353331425;7025.297470252934;7033.577985320897;7331.816704582215;7350.117985841734;7402.888956665762;7419.4806363554035;7419.962900185465;4748.145333839942;4778.235482322951;4784.593309568726;4792.281157826214;4797.992421591365;6902;7088.468364872552;7128.4653650977425;7134.892976605459;7143.6428178591905;6891.9317505786685;6899.793006209822;6902.8619427612175;6904.585724856524;6906.723731050702;6735.4274886635185;6872.969054641843;6892.207396149507;6894.620795856075;6910.170779506491;6716.261211266659;6752.155980502437;6772.221194562689;6772.55978361405;6774.42417394527;6839.076724642109;6889.311068893071;6929.133858267716;6934.890417533171;6935.306469353024;6592.934070659232;6677.699503522256;6716.1604799400075;6742.898856517254;6779.35596118368 19:05:51 INFO - PROCESS | 3016 | |5;yui.html;855.0594346219158;856.738694698117;863.7408777366796;864.6498168241865;864.8270345930812;13579.3210339483;13843.446262149515;13913.930430347835;13925.37335819888;13972.231527265996;13440.865591344083;13469.259190744506;13515.662108447294;13533.593992180226;13579;665.5507532415612;678.1015154919727;790.4466873188762;812.2608426332039;814.3973459639853;813.6094674556217;818.7339114787718;820.2453742556833;821.1870248454018;823.197382552013;859.1322764008365;859.6131740716671;860.9139086091373;866.0343716755804;868.1665601022994;857.2884505860152;858.4891989266439;860.1398601398602;861.9396642235046;861.9956900215459;631.2992578238152;633.4267487923437;634.3022675057446;635;635.0347471842773;13442.260675662834;13443.126196797177;13537.729245415136;13552.051356405056;13559.932200339033;12362.44369003397;12831.87168128316;12876.742465150644;12935.935320323431;13232.470701171942;10163.898361016443;10528.526216320284;10539.63111291101;10579.73550661232;10641.467926603716;3642.6721595056574;3715.4241092630687;3732.8320225589914;3749.1189570450924;3810.618938106195;40748;40908.590914090775;40960.795196024126;41225.38161927574;41315.38026929599;9585.952070239744;9863.210943124534;9971.601135954626;10181.083702466814;10207.234457415723;17247.482575522754;17257.741133883002;17369.305227790748;17416.47750567485;18115.184816683282;7666.693332266758;7780.649870755829;7782.221777822286;7892.250236227549;7966.522008679498;4238.3430568261965;4278.63631591312;4318.265894797829;4338.240807858612;4372.715773474714;3077;3089.2276930767307;3101.65881753007;3103;3110.9889285982144;556.2074044486591;577.8555361159711;579.1168468086119;591.7869566955892;591.8017464149558;641.6631268583938;662.2218892800939;667.4960404894274;670.7920544631082;677.3395938959475;7902.24928631779;7977.641006154737;7978.880316795253;7979.64346061171;8136.1863813618165;653.6960313454266;662.3740565165969;676.1649363036646;682.8497730499282;684.9589024658536;3752.887413377603;3773.471713960048;3810.657040866335;3911.0808959894403;3930.7028680535354;53107.46892531103;53400.198997015075;56062.15906761402;57667.711661441426;57910.7104464475;48921.2661810066;50027.749861250464;50625.49374506208;51022;51638.74180629073;42374;45633;45951;46120.769396152806;47103;7675.232476752503;7713.344365728976;7915.84168316642;8051.959740201261;8107.3108785753875;34748;35162.648373515935;35842.28315433729;36038.8198059008;36135.27729445344;41854.79072604617;42185.156296874506;43976.78011609922;45350.77324613356;45784.54215457936;10352.327098738559;10376.584936602452;10460.63387781424;10497.422641754776;10505.15958723285;11652.242604230698;11802.52789888395;11994.220375675903;12125.57560485414;12171.573994910135;9855.162311203629;9958.900410995797;10361.84457233127;10481.528331224961;10487.79024419492;10533.104686101768;10681.57273709043;10900;10956.397398143179;11249.887501124884;10086;10158.288919775545;10205;10326.50263725149;10512.632057877938;8871.423357481743;9342.53287335617;9385.530723463937;9417.952910235404;9498.715038548855;7926.762197134095;8532.23209911111;8581.442206256574;8798.34012449056;8919.241864441596 19:05:51 INFO - PROCESS | 3016 | __end_tp_report 19:05:51 INFO - PROCESS | 3016 | __start_cc_report 19:05:51 INFO - PROCESS | 3016 | _x_x_mozilla_cycle_collect,303 19:05:51 INFO - PROCESS | 3016 | __end_cc_report 19:05:51 INFO - PROCESS | 3016 | __startTimestamp1450839951682__endTimestamp 19:05:51 INFO - PROCESS | 3016 | 19:05:51 INFO - PROCESS | 3016 | ------- Summary: start ------- 19:05:51 INFO - PROCESS | 3016 | Number of tests: 6 19:05:51 INFO - PROCESS | 3016 | 19:05:51 INFO - PROCESS | 3016 | [#0] dojo.html Cycles:165 Average:5344.22 Median:5550.06 stddev:592.04 (10.7%) stddev-sans-first:569.36 19:05:51 INFO - PROCESS | 3016 | Values: 3195.8 3238.1 3248.8 3267.0 3278.7 5182.6 5331.9 5385.6 5389.1 5390.6 5219.9 5297.4 5301.5 5328.4 5337.7 4849.4 4915.2 4929.7 4967.0 4986.3 4844.1 4933.7 4935.3 4940.5 4968.7 4807.8 4867.7 4959.9 4993.2 5030.7 4865.5 4890.5 4907.9 4908.8 4953.1 4754.2 4851.6 4892.7 4894.7 4926.7 5098.1 5135.8 5165.5 5176.9 5238.9 5733.0 5745.7 5751.9 5757.3 5786.3 5685.4 5793.1 5806.1 5807.7 5821.3 5167.5 5179.7 5217.7 5221.2 5233.2 5784.3 5787.4 5791.5 5792.9 5833.5 5583.8 5614.0 5644.6 5708.4 5710.2 5735.3 5779.7 5816.3 5818.6 5821.5 5705.2 5746.8 5785.9 5795.1 5795.3 5759.3 5799.6 5806.0 5815.5 5851.2 4463.6 4475.6 4477.4 4483.2 4525.4 3928.3 3951.2 3993.8 4018.2 4056.0 5362.1 5373.5 5386.9 5391.7 5405.2 5742.1 5762.2 5765.3 5785.6 5789.7 5128.5 5231.3 5313.4 5340.2 5431.9 4866.3 4881.3 4894.5 4903.5 4929.0 5903.1 5924.6 5941.1 5948.3 5964.2 5717.7 5823.5 5827.0 5905.3 5922.2 5959.6 5986.1 6005.4 6009.6 6017.9 5502.6 5721.5 5728.7 5733.3 5754.9 5725.3 5773.1 5860.2 5905.9 5908.0 5722.9 5739.5 5742.1 5744.1 5746.8 5613.3 5645.3 5687.5 5699.5 5699.6 5500.5 5513.8 5514.9 5557.8 5595.2 5621.2 5653.4 5663.7 5692.5 5694.5 5356.8 5441.8 5537.4 5550.1 5564.2 19:05:51 INFO - PROCESS | 3016 | 19:05:51 INFO - PROCESS | 3016 | [#1] ext.html Cycles:180 Average:43821.97 Median:35739.64 stddev:70569.03 (197.5%) stddev-sans-first:70692.26 19:05:51 INFO - PROCESS | 3016 | Values: 568.4 586.6 606.6 615.2 617.9 29493.9 37002.0 37449.0 37626.1 37676.0 41292.2 41739.2 41997.6 42064.0 42159.4 8631.4 8751.0 8829.6 8873.3 8885.7 8647.4 8675.1 8721.1 8740.6 8750.5 8591.9 8736.9 8771.2 8771.6 8771.7 8694.7 8721.7 8728.3 8746.7 8780.6 8541.7 8675.5 8685.3 8720.6 8721.1 39634.6 39807.0 39906.2 39935.2 40042.4 3353.4 3528.9 3704.2 3796.1 4026.4 29017.0 29098.4 29918.7 30106.5 30562.8 3933.0 3947.5 3997.8 4046.5 4114.2 267356.0 268143.0 268248.0 268271.0 268959.0 49505.3 54543.7 54807.5 55151.0 55184.4 44050.3 58811.4 59606.7 59798.4 59811.7 13642.5 13885.2 13893.8 13900.4 13910.2 10675.4 10700.9 10702.5 10752.5 10773.9 17846.4 18552.4 18692.3 18692.8 18709.5 7859.2 7992.5 8042.6 8060.2 8060.2 843.9 845.0 936.8 994.5 1078.0 26190.0 26792.2 26894.2 27706.6 29007.4 954.7 997.5 1005.3 1074.4 1150.2 13554.9 13839.9 13871.6 13949.5 15228.9 241684.0 243865.0 244999.0 245960.0 246867.0 46877.3 47505.3 47635.0 47660.3 47689.3 1322.3 1351.2 1355.2 1364.1 1369.8 27668.7 28480.4 28764.1 28832.6 28863.4 45104.5 45119.3 45179.0 45335.3 45465.0 295233.0 297075.0 297951.0 298092.0 298205.0 30027.2 30165.2 30345.4 30467.2 30481.7 40383.0 41189.8 41716.4 42091.8 42283.2 34579.8 35184.6 35285.6 35405.8 35838.8 35024.6 35204.0 35325.6 35385.8 35419.0 34690.8 35081.8 35188.8 35231.5 35640.5 31216.8 31310.2 31594.8 32106.8 32307.0 24062.0 32207.7 33867.3 33984.8 34142.1 19:05:51 INFO - PROCESS | 3016 | 19:05:51 INFO - PROCESS | 3016 | [#2] jquery.html Cycles:180 Average:29673.60 Median:17964.57 stddev:88151.63 (490.7%) stddev-sans-first:88371.43 19:05:51 INFO - PROCESS | 3016 | Values: 352.8 358.3 358.9 361.0 361.0 16509.8 17107.5 17549.8 17930.7 18265.2 10352.3 10765.7 14291.3 14332.7 14340.7 4882.9 5008.5 5197.5 5378.7 5391.1 4425.6 5326.5 5339.0 5367.1 5370.6 5619.7 5629.8 6600.9 6859.1 6862.0 6687.3 6796.2 6805.8 6836.5 6839.8 6644.7 6648.7 6648.9 6654.6 6661.2 22090.8 22743.8 23229.2 23309.1 23339.8 2243.6 2299.1 2323.3 2348.7 2361.6 13958.2 14157.3 14299.4 14457.9 14903.7 1869.7 1885.3 1928.4 1966.3 1977.3 65115.3 68531.7 68846.0 68913.7 71140.6 14957.6 15149.3 15456.8 15480.9 15484.8 24457.6 24467.9 24475.6 24664.8 24707.1 8582.6 8592.4 8613.4 8682.2 8880.9 7234.4 7303.9 7323.5 7351.7 7375.4 7644.0 7663.8 7676.0 7773.1 7904.2 1832.5 2916.0 3121.9 3122.4 3128.4 407.8 411.2 411.5 796.6 922.1 10862.3 11041.3 11197.8 11276.5 16715.6 861.3 862.1 942.7 974.1 977.9 6572.9 9828.6 9865.1 9964.1 9974.7 526873.0 534282.0 537776.0 543746.0 554751.0 80123.0 81371.6 83248.6 83384.2 83814.5 1148.1 1153.7 1190.8 1192.2 1193.1 15521.7 15573.9 15688.5 15818.8 15940.4 35221.8 35351.1 35386.5 35441.3 35570.8 42007.0 43040.6 43260.8 43736.3 44470.6 9300.0 9673.3 9720.1 9772.7 9807.9 11485.0 16816.7 16915.5 17454.9 17699.0 13123.5 13196.5 13683.4 13702.9 13712.3 14427.4 14507.0 14536.8 14773.0 14989.2 13914.6 13966.9 14133.6 14246.6 14592.5 9580.8 9670.8 9713.7 9738.8 9865.5 10073.1 11984.3 13771.7 14175.4 14392.9 19:05:51 INFO - PROCESS | 3016 | 19:05:51 INFO - PROCESS | 3016 | [#3] mootools.html Cycles:180 Average:5124.91 Median:6360.67 stddev:2590.14 (40.7%) stddev-sans-first:2582.48 19:05:51 INFO - PROCESS | 3016 | Values: 1424.6 1483.4 1594.7 1602.4 1723.2 6661.9 6777.0 6805.5 7156.7 7210.2 7065.4 7205.2 7226.1 7269.6 7323.9 2171.1 2206.1 2214.2 2219.0 2222.0 2221.2 2226.5 2292.2 2310.5 2317.2 2225.7 2226.9 2241.8 2255.2 2281.0 2207.2 2226.9 2233.1 2237.8 2249.0 2251.9 2280.3 2285.8 2289.8 2294.7 7276.3 7284.7 7292.8 7312.0 7391.0 4376.5 4417.6 4428.2 4441.2 4445.8 3010.5 3037.4 3093.5 3124.0 3129.8 1006.9 1011.3 1032.0 1035.3 1039.9 9710.4 9785.4 9799.9 9815.3 9824.7 4045.5 4058.5 4080.4 4093.5 4103.1 8488.7 8546.5 8547.1 8555.0 8555.7 4448.2 4471.1 4477.9 4487.0 4488.5 3911.6 3972.1 4014.6 4027.5 4045.9 3543.6 3568.0 3580.2 3594.0 3624.8 1132.4 1139.5 1140.3 1142.0 1145.5 975.7 978.1 982.8 1107.2 1357.4 6752.3 6772.2 6788.0 6826.9 6840.7 490.4 504.8 512.7 515.2 516.8 5533.3 5547.7 5550.0 5590.8 5595.2 7884.2 8026.0 8119.1 8380.3 8491.4 8452.5 8515.1 8529.7 8552.5 8563.2 6715.9 6775.5 6784.1 6789.3 6854.8 7009.8 7031.0 7069.2 7073.7 7104.0 7439.3 7532.2 7548.4 7637.1 7813.8 7794.5 7915.7 7985.5 7987.7 7994.2 6416.3 6608.8 6611.7 6641.4 6681.2 7070.5 7105.6 7114.3 7141.5 7176.9 6497.8 6619.0 6700.3 6766.3 6787.5 6470.6 6533.5 6661.4 6734.8 6794.7 6610.3 6615.8 6638.6 6645.7 6649.5 5981.6 6138.2 6144.5 6152.0 6156.5 6292.7 6299.5 6328.0 6356.1 6365.2 19:05:51 INFO - PROCESS | 3016 | 19:05:51 INFO - PROCESS | 3016 | [#4] prototype.html Cycles:180 Average:5659.28 Median:6429.11 stddev:1755.33 (27.3%) stddev-sans-first:1714.15 19:05:51 INFO - PROCESS | 3016 | Values: 334.7 336.1 338.4 344.1 346.3 6346.1 6357.1 6390.5 6424.2 6506.9 6341.7 6406.0 6416.5 6429.3 6429.8 4827.8 4829.3 4858.1 4862.0 4874.9 4869.1 4875.0 4879.1 4882.9 4890.4 4612.0 4615.6 4686.9 4688.6 4738.2 4662.7 4667.6 4680.0 4682.6 4691.9 4074.0 4090.5 4097.3 4100.4 4103.4 5951.1 5954.0 5957.8 5966.0 5970.5 5412.7 5432.8 5487.1 5496.2 5501.9 6569.2 6604.4 6608.5 6618.8 6619.3 4500.5 4500.8 4506.7 4508.4 4510.9 6970.1 7047.9 7096.4 7107.9 7126.3 4650.9 4683.0 4701.0 4703.0 4704.8 4723.7 4755.1 4761.9 4763.5 4768.7 5546.2 5554.8 5557.9 5560.7 5570.1 6695.8 6700.2 6811.7 6813.7 6819.0 1660.0 1675.9 1680.0 1680.8 1683.8 1105.0 1111.1 1114.6 1125.1 1128.6 6429.0 6442.0 6449.7 6457.4 6459.5 7017.5 7019.6 7022.5 7024.8 7033.8 6368.2 6372.7 6420.3 6532.8 6534.3 3822.6 3843.3 3853.3 3855.4 3858.3 7409.0 7415.5 7418.0 7437.4 7447.5 7103.9 7275.9 7289.3 7291.0 7305.6 7336.5 7361.9 7367.4 7373.4 7388.8 6948.7 7067.7 7081.8 7086.9 7091.9 6979.1 7016.1 7017.3 7025.3 7033.6 7331.8 7350.1 7402.9 7419.5 7420.0 4748.1 4778.2 4784.6 4792.3 4798.0 6902.0 7088.5 7128.5 7134.9 7143.6 6891.9 6899.8 6902.9 6904.6 6906.7 6735.4 6873.0 6892.2 6894.6 6910.2 6716.3 6752.2 6772.2 6772.6 6774.4 6839.1 6889.3 6929.1 6934.9 6935.3 6592.9 6677.7 6716.2 6742.9 6779.4 19:05:51 INFO - PROCESS | 3016 | 19:05:51 INFO - PROCESS | 3016 | [#5] yui.html Cycles:180 Average:13349.40 Median:45708.77 stddev:15314.16 (33.5%) stddev-sans-first:15328.37 19:05:51 INFO - PROCESS | 3016 | Values: 855.1 856.7 863.7 864.6 864.8 13579.3 13843.4 13913.9 13925.4 13972.2 13440.9 13469.3 13515.7 13533.6 13579.0 665.6 678.1 790.4 812.3 814.4 813.6 818.7 820.2 821.2 823.2 859.1 859.6 860.9 866.0 868.2 857.3 858.5 860.1 861.9 862.0 631.3 633.4 634.3 635.0 635.0 13442.3 13443.1 13537.7 13552.1 13559.9 12362.4 12831.9 12876.7 12935.9 13232.5 10163.9 10528.5 10539.6 10579.7 10641.5 3642.7 3715.4 3732.8 3749.1 3810.6 40748.0 40908.6 40960.8 41225.4 41315.4 9586.0 9863.2 9971.6 10181.1 10207.2 17247.5 17257.7 17369.3 17416.5 18115.2 7666.7 7780.6 7782.2 7892.3 7966.5 4238.3 4278.6 4318.3 4338.2 4372.7 3077.0 3089.2 3101.7 3103.0 3111.0 556.2 577.9 579.1 591.8 591.8 641.7 662.2 667.5 670.8 677.3 7902.2 7977.6 7978.9 7979.6 8136.2 653.7 662.4 676.2 682.8 685.0 3752.9 3773.5 3810.7 3911.1 3930.7 53107.5 53400.2 56062.2 57667.7 57910.7 48921.3 50027.7 50625.5 51022.0 51638.7 42374.0 45633.0 45951.0 46120.8 47103.0 7675.2 7713.3 7915.8 8052.0 8107.3 34748.0 35162.6 35842.3 36038.8 36135.3 41854.8 42185.2 43976.8 45350.8 45784.5 10352.3 10376.6 10460.6 10497.4 10505.2 11652.2 11802.5 11994.2 12125.6 12171.6 9855.2 9958.9 10361.8 10481.5 10487.8 10533.1 10681.6 10900.0 10956.4 11249.9 10086.0 10158.3 10205.0 10326.5 10512.6 8871.4 9342.5 9385.5 9418.0 9498.7 7926.8 8532.2 8581.4 8798.3 8919.2 19:05:51 INFO - PROCESS | 3016 | -------- Summary: end -------- 19:05:51 INFO - PROCESS | 3016 | 19:05:52 INFO - TEST-INFO | 3016: exit 0 19:05:52 INFO - TEST-OK | dromaeo_css | took 1110116ms 19:05:52 INFO - TEST-START | kraken 19:05:52 INFO - operating with platform_type : linux_ 19:05:52 INFO - Initialising browser for kraken test... 19:05:52 INFO - TEST-INFO | started process 3251 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprIc_PC/profile http://localhost:36106/getInfo.html) 19:05:56 INFO - PROCESS | 3251 | __metrics Screen width/height:1600/1200 19:05:56 INFO - PROCESS | 3251 | colorDepth:24 19:05:56 INFO - PROCESS | 3251 | Browser inner width/height: 1024/697 19:05:56 INFO - PROCESS | 3251 | __metrics 19:05:56 INFO - PROCESS | 3251 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:05:57 INFO - TEST-INFO | 3251: exit 0 19:05:57 INFO - Browser initialized. 19:05:57 INFO - Running cycle 1/1 for kraken test... 19:05:57 INFO - TEST-INFO | started process 3372 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmprIc_PC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:06:09 INFO - PROCESS | 3372 | RSS: Main: 151126016 19:06:09 INFO - PROCESS | 3372 | 19:06:11 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:36106/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36106/tests/kraken/driver.html?testName=audio-beat-detection) 19:06:12 INFO - PROCESS | 3372 | RSS: Main: 151302144 19:06:12 INFO - PROCESS | 3372 | 19:06:15 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:36106/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36106/tests/kraken/driver.html?testName=audio-dft) 19:06:15 INFO - PROCESS | 3372 | RSS: Main: 151752704 19:06:15 INFO - PROCESS | 3372 | 19:06:18 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:36106/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36106/tests/kraken/driver.html?testName=audio-fft) 19:06:19 INFO - PROCESS | 3372 | RSS: Main: 145694720 19:06:19 INFO - PROCESS | 3372 | 19:06:21 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:36106/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36106/tests/kraken/driver.html?testName=audio-oscillator) 19:06:21 INFO - PROCESS | 3372 | RSS: Main: 146452480 19:06:21 INFO - PROCESS | 3372 | 19:06:24 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:36106/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36106/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:06:24 INFO - PROCESS | 3372 | RSS: Main: 147120128 19:06:24 INFO - PROCESS | 3372 | 19:06:27 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:36106/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36106/tests/kraken/driver.html?testName=imaging-darkroom) 19:06:28 INFO - PROCESS | 3372 | RSS: Main: 147255296 19:06:28 INFO - PROCESS | 3372 | 19:06:31 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:36106/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36106/tests/kraken/driver.html?testName=imaging-desaturate) 19:06:32 INFO - PROCESS | 3372 | RSS: Main: 148508672 19:06:32 INFO - PROCESS | 3372 | 19:06:35 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:36106/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36106/tests/kraken/driver.html?testName=json-parse-financial) 19:06:35 INFO - PROCESS | 3372 | RSS: Main: 148787200 19:06:35 INFO - PROCESS | 3372 | 19:06:37 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:36106/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36106/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:06:37 INFO - PROCESS | 3372 | RSS: Main: 149573632 19:06:37 INFO - PROCESS | 3372 | 19:06:39 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:36106/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36106/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:06:40 INFO - PROCESS | 3372 | RSS: Main: 148045824 19:06:40 INFO - PROCESS | 3372 | 19:06:42 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:36106/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36106/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:06:42 INFO - PROCESS | 3372 | RSS: Main: 148512768 19:06:42 INFO - PROCESS | 3372 | 19:06:45 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:36106/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:06:46 INFO - PROCESS | 3372 | RSS: Main: 148627456 19:06:46 INFO - PROCESS | 3372 | 19:06:48 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:36106/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:06:49 INFO - PROCESS | 3372 | RSS: Main: 150212608 19:06:49 INFO - PROCESS | 3372 | 19:06:50 INFO - PROCESS | 3372 | Cycle 1(1): loaded http://localhost:36106/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36106/tests/kraken/driver.html?testName=ai-astar) 19:06:51 INFO - PROCESS | 3372 | RSS: Main: 148992000 19:06:51 INFO - PROCESS | 3372 | 19:06:51 INFO - PROCESS | 3372 | __start_tp_report 19:06:51 INFO - PROCESS | 3372 | _x_x_mozilla_page_load 19:06:51 INFO - PROCESS | 3372 | _x_x_mozilla_page_load_details 19:06:51 INFO - PROCESS | 3372 | |i|pagename|runs| 19:06:51 INFO - PROCESS | 3372 | |0;ai-astar;110;106;112;111;111;123;111;110;109;111 19:06:51 INFO - PROCESS | 3372 | |1;audio-beat-detection;156;133;154;164;129;150;163;127;169;126 19:06:51 INFO - PROCESS | 3372 | |2;audio-dft;161;162;164;165;162;161;160;164;167;160 19:06:51 INFO - PROCESS | 3372 | |3;audio-fft;71;72;74;71;72;72;72;132;78;71 19:06:51 INFO - PROCESS | 3372 | |4;audio-oscillator;93;93;146;93;94;99;132;93;95;145 19:06:51 INFO - PROCESS | 3372 | |5;imaging-gaussian-blur;109;110;110;109;109;109;110;110;110;110 19:06:51 INFO - PROCESS | 3372 | |6;imaging-darkroom;146;147;148;147;145;148;145;146;146;148 19:06:51 INFO - PROCESS | 3372 | |7;imaging-desaturate;97;96;96;97;103;96;95;96;97;97 19:06:51 INFO - PROCESS | 3372 | |8;json-parse-financial;61;61;62;60;62;62;63;62;56;58 19:06:51 INFO - PROCESS | 3372 | |9;json-stringify-tinderbox;67;68;67;69;68;67;67;68;67;68 19:06:51 INFO - PROCESS | 3372 | |10;stanford-crypto-aes;84;86;86;85;84;84;87;85;96;86 19:06:51 INFO - PROCESS | 3372 | |11;stanford-crypto-ccm;114;123;122;120;119;124;126;116;125;123 19:06:51 INFO - PROCESS | 3372 | |12;stanford-crypto-pbkdf2;152;147;152;148;148;147;149;150;147;137 19:06:51 INFO - PROCESS | 3372 | |13;stanford-crypto-sha256-iterative;68;66;66;68;67;65;66;67;67;68 19:06:51 INFO - PROCESS | 3372 | __end_tp_report 19:06:51 INFO - PROCESS | 3372 | __start_cc_report 19:06:51 INFO - PROCESS | 3372 | _x_x_mozilla_cycle_collect,730 19:06:51 INFO - PROCESS | 3372 | __end_cc_report 19:06:51 INFO - PROCESS | 3372 | __startTimestamp1450840011117__endTimestamp 19:06:51 INFO - PROCESS | 3372 | 19:06:51 INFO - PROCESS | 3372 | ------- Summary: start ------- 19:06:51 INFO - PROCESS | 3372 | Number of tests: 14 19:06:51 INFO - PROCESS | 3372 | 19:06:51 INFO - PROCESS | 3372 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:4.40 (4.0%) stddev-sans-first:4.64 19:06:51 INFO - PROCESS | 3372 | Values: 110.0 106.0 112.0 111.0 111.0 123.0 111.0 110.0 109.0 111.0 19:06:51 INFO - PROCESS | 3372 | 19:06:51 INFO - PROCESS | 3372 | [#1] audio-beat-detection Cycles:10 Average:147.10 Median:155.00 stddev:16.76 (10.8%) stddev-sans-first:17.47 19:06:51 INFO - PROCESS | 3372 | Values: 156.0 133.0 154.0 164.0 129.0 150.0 163.0 127.0 169.0 126.0 19:06:51 INFO - PROCESS | 3372 | 19:06:51 INFO - PROCESS | 3372 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:2.32 (1.4%) stddev-sans-first:2.39 19:06:51 INFO - PROCESS | 3372 | Values: 161.0 162.0 164.0 165.0 162.0 161.0 160.0 164.0 167.0 160.0 19:06:51 INFO - PROCESS | 3372 | 19:06:51 INFO - PROCESS | 3372 | [#3] audio-fft Cycles:10 Average:78.50 Median:72.00 stddev:18.92 (26.3%) stddev-sans-first:19.87 19:06:51 INFO - PROCESS | 3372 | Values: 71.0 72.0 74.0 71.0 72.0 72.0 72.0 132.0 78.0 71.0 19:06:51 INFO - PROCESS | 3372 | 19:06:51 INFO - PROCESS | 3372 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:93.00 stddev:22.93 (24.7%) stddev-sans-first:23.65 19:06:51 INFO - PROCESS | 3372 | Values: 93.0 93.0 146.0 93.0 94.0 99.0 132.0 93.0 95.0 145.0 19:06:51 INFO - PROCESS | 3372 | 19:06:51 INFO - PROCESS | 3372 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 19:06:51 INFO - PROCESS | 3372 | Values: 109.0 110.0 110.0 109.0 109.0 109.0 110.0 110.0 110.0 110.0 19:06:51 INFO - PROCESS | 3372 | 19:06:51 INFO - PROCESS | 3372 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:1.17 (0.8%) stddev-sans-first:1.22 19:06:51 INFO - PROCESS | 3372 | Values: 146.0 147.0 148.0 147.0 145.0 148.0 145.0 146.0 146.0 148.0 19:06:51 INFO - PROCESS | 3372 | 19:06:51 INFO - PROCESS | 3372 | [#7] imaging-desaturate Cycles:10 Average:97.00 Median:96.50 stddev:2.21 (2.3%) stddev-sans-first:2.35 19:06:51 INFO - PROCESS | 3372 | Values: 97.0 96.0 96.0 97.0 103.0 96.0 95.0 96.0 97.0 97.0 19:06:51 INFO - PROCESS | 3372 | 19:06:51 INFO - PROCESS | 3372 | [#8] json-parse-financial Cycles:10 Average:60.70 Median:62.00 stddev:2.16 (3.5%) stddev-sans-first:2.29 19:06:51 INFO - PROCESS | 3372 | Values: 61.0 61.0 62.0 60.0 62.0 62.0 63.0 62.0 56.0 58.0 19:06:51 INFO - PROCESS | 3372 | 19:06:51 INFO - PROCESS | 3372 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 19:06:51 INFO - PROCESS | 3372 | Values: 67.0 68.0 67.0 69.0 68.0 67.0 67.0 68.0 67.0 68.0 19:06:51 INFO - PROCESS | 3372 | 19:06:51 INFO - PROCESS | 3372 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.00 stddev:3.56 (4.1%) stddev-sans-first:3.68 19:06:51 INFO - PROCESS | 3372 | Values: 84.0 86.0 86.0 85.0 84.0 84.0 87.0 85.0 96.0 86.0 19:06:51 INFO - PROCESS | 3372 | 19:06:51 INFO - PROCESS | 3372 | [#11] stanford-crypto-ccm Cycles:10 Average:121.20 Median:123.00 stddev:3.91 (3.2%) stddev-sans-first:3.16 19:06:51 INFO - PROCESS | 3372 | Values: 114.0 123.0 122.0 120.0 119.0 124.0 126.0 116.0 125.0 123.0 19:06:51 INFO - PROCESS | 3372 | 19:06:51 INFO - PROCESS | 3372 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:148.50 stddev:4.22 (2.8%) stddev-sans-first:4.18 19:06:51 INFO - PROCESS | 3372 | Values: 152.0 147.0 152.0 148.0 148.0 147.0 149.0 150.0 147.0 137.0 19:06:51 INFO - PROCESS | 3372 | 19:06:51 INFO - PROCESS | 3372 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.00 19:06:51 INFO - PROCESS | 3372 | Values: 68.0 66.0 66.0 68.0 67.0 65.0 66.0 67.0 67.0 68.0 19:06:51 INFO - PROCESS | 3372 | -------- Summary: end -------- 19:06:51 INFO - PROCESS | 3372 | 19:06:51 INFO - TEST-INFO | 3372: exit 0 19:06:51 INFO - TEST-OK | kraken | took 59619ms 19:06:51 INFO - TEST-START | v8_7 19:06:51 INFO - operating with platform_type : linux_ 19:06:51 INFO - Initialising browser for v8_7 test... 19:06:51 INFO - TEST-INFO | started process 3661 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAUovYx/profile http://localhost:36106/getInfo.html) 19:06:56 INFO - PROCESS | 3661 | __metrics Screen width/height:1600/1200 19:06:56 INFO - PROCESS | 3661 | colorDepth:24 19:06:56 INFO - PROCESS | 3661 | Browser inner width/height: 1024/697 19:06:56 INFO - PROCESS | 3661 | __metrics 19:06:56 INFO - PROCESS | 3661 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:06:57 INFO - TEST-INFO | 3661: exit 0 19:06:57 INFO - Browser initialized. 19:06:57 INFO - Running cycle 1/1 for v8_7 test... 19:06:57 INFO - TEST-INFO | started process 3781 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAUovYx/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:07:08 INFO - PROCESS | 3781 | RSS: Main: 151146496 19:07:08 INFO - PROCESS | 3781 | 19:07:30 INFO - PROCESS | 3781 | Cycle 1(1): loaded http://localhost:36106/tests/v8_7/run.html (next: http://localhost:36106/tests/v8_7/run.html) 19:07:30 INFO - PROCESS | 3781 | RSS: Main: 147357696 19:07:30 INFO - PROCESS | 3781 | 19:07:30 INFO - PROCESS | 3781 | __start_tp_report 19:07:30 INFO - PROCESS | 3781 | _x_x_mozilla_page_load 19:07:30 INFO - PROCESS | 3781 | _x_x_mozilla_page_load_details 19:07:30 INFO - PROCESS | 3781 | |i|pagename|runs| 19:07:30 INFO - PROCESS | 3781 | |0;Richards;164.7175094712568 19:07:30 INFO - PROCESS | 3781 | |1;DeltaBlue;187.30099269526127 19:07:30 INFO - PROCESS | 3781 | |2;Encrypt;279.87685418415896 19:07:30 INFO - PROCESS | 3781 | |3;Decrypt;5159.79381443299 19:07:30 INFO - PROCESS | 3781 | |4;RayTrace;1061.5711252653928 19:07:30 INFO - PROCESS | 3781 | |5;Earley;719.9424046076314 19:07:30 INFO - PROCESS | 3781 | |6;Boyer;12268.292682926829 19:07:30 INFO - PROCESS | 3781 | |7;RegExp;25450 19:07:30 INFO - PROCESS | 3781 | |8;Splay;805.1529790660226 19:07:30 INFO - PROCESS | 3781 | |9;NavierStokes;4845.410628019324 19:07:30 INFO - PROCESS | 3781 | __end_tp_report 19:07:30 INFO - PROCESS | 3781 | __startTimestamp1450840050545__endTimestamp 19:07:30 INFO - PROCESS | 3781 | 19:07:30 INFO - PROCESS | 3781 | ------- Summary: start ------- 19:07:30 INFO - PROCESS | 3781 | Number of tests: 10 19:07:30 INFO - PROCESS | 3781 | 19:07:30 INFO - PROCESS | 3781 | [#0] Richards Cycles:1 Average:164.72 Median:164.72 stddev:0.00 (0.0%) 19:07:30 INFO - PROCESS | 3781 | Values: 164.7 19:07:30 INFO - PROCESS | 3781 | 19:07:30 INFO - PROCESS | 3781 | [#1] DeltaBlue Cycles:1 Average:187.30 Median:187.30 stddev:0.00 (0.0%) 19:07:30 INFO - PROCESS | 3781 | Values: 187.3 19:07:30 INFO - PROCESS | 3781 | 19:07:30 INFO - PROCESS | 3781 | [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 19:07:30 INFO - PROCESS | 3781 | Values: 279.9 19:07:30 INFO - PROCESS | 3781 | 19:07:30 INFO - PROCESS | 3781 | [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 19:07:30 INFO - PROCESS | 3781 | Values: 5159.8 19:07:30 INFO - PROCESS | 3781 | 19:07:30 INFO - PROCESS | 3781 | [#4] RayTrace Cycles:1 Average:1061.57 Median:1061.57 stddev:0.00 (0.0%) 19:07:30 INFO - PROCESS | 3781 | Values: 1061.6 19:07:30 INFO - PROCESS | 3781 | 19:07:30 INFO - PROCESS | 3781 | [#5] Earley Cycles:1 Average:719.94 Median:719.94 stddev:0.00 (0.0%) 19:07:30 INFO - PROCESS | 3781 | Values: 719.9 19:07:30 INFO - PROCESS | 3781 | 19:07:30 INFO - PROCESS | 3781 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 19:07:30 INFO - PROCESS | 3781 | Values: 12268.3 19:07:30 INFO - PROCESS | 3781 | 19:07:30 INFO - PROCESS | 3781 | [#7] RegExp Cycles:1 Average:25450.00 Median:25450.00 stddev:0.00 (0.0%) 19:07:30 INFO - PROCESS | 3781 | Values: 25450.0 19:07:30 INFO - PROCESS | 3781 | 19:07:30 INFO - PROCESS | 3781 | [#8] Splay Cycles:1 Average:805.15 Median:805.15 stddev:0.00 (0.0%) 19:07:30 INFO - PROCESS | 3781 | Values: 805.2 19:07:30 INFO - PROCESS | 3781 | 19:07:30 INFO - PROCESS | 3781 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 19:07:30 INFO - PROCESS | 3781 | Values: 4845.4 19:07:30 INFO - PROCESS | 3781 | -------- Summary: end -------- 19:07:30 INFO - PROCESS | 3781 | 19:07:31 INFO - TEST-INFO | 3781: exit 0 19:07:31 INFO - TEST-OK | v8_7 | took 39436ms 19:07:31 INFO - SUITE-END | took 1209s 19:07:31 INFO - Completed test suite (00:20:09) 19:07:31 INFO - Working with test: dromaeo_css 19:07:31 INFO - Generating results file: dromaeo_css 19:07:31 INFO - Working with test: kraken 19:07:31 INFO - Generating results file: kraken 19:07:31 INFO - javascript benchmark 19:07:31 INFO - Working with test: v8_7 19:07:31 INFO - Generating results file: v8_7 19:07:31 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:07:31 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 19:07:31 INFO - process_Request line: dromaeo_css 7021.08 graph.html#tests=[[72,63,43]] 19:07:31 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:07:31 INFO - process_Request line: kraken 1511.40 graph.html#tests=[[232,63,43]] 19:07:31 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:07:31 INFO - process_Request line: v8_7 20784.34 graph.html#tests=[[230,63,43]] 19:07:31 INFO - RETURN: dromaeo_css: 7021.08 19:07:31 INFO - RETURN: kraken: 1511.40 19:07:31 INFO - RETURN: v8_7: 20784.34 19:07:31 INFO - javascript benchmark 19:07:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3195.7762956593033, 3238.0609623209284, 3248.837558122096, 3266.983665081674, 3278.7049165575095, 5182.559482443988, 5331.920021199685, 5385.623006389555, 5389.110796718542, 5390.649607775496, 5219.9478005219935, 5297.364316282052, 5301.549368303689, 5328.387235467912, 5337.6797392156495, 4849.418069831608, 4915.188993816016, 4929.728864912428, 4967.0, 4986.326845875815, 4844.055409195208, 4933.654644174909, 4935.259711043336, 4940.481249468808, 4968.677035992667, 4807.807687692488, 4867.70793752376, 4959.876003099934, 4993.151164302041, 5030.748462576893, 4865.464798872121, 4890.486498917598, 4907.852764417074, 4908.77910494025, 4953.108440480712, 4754.215554433515, 4851.611871050308, 4892.68197567157, 4894.681845680019, 4926.679765815246, 5098.133317336062, 5135.820246291362, 5165.483451654842, 5176.870578235536, 5238.947610523884, 5733.0, 5745.683987380692, 5751.913721294142, 5757.280339957505, 5786.276715410574, 5685.374608793029, 5793.102069179284, 5806.129080637938, 5807.738651760681, 5821.330546987108, 5167.48325167484, 5179.689218646856, 5217.713025783581, 5221.164613661834, 5233.241180028951, 5784.2769653793275, 5787.363390027093, 5791.536677065825, 5792.913106303409, 5833.50415214703, 5583.832485025375, 5614.045612245928, 5644.604877658525, 5708.400617935057, 5710.200571919934, 5735.283089613798, 5779.711014449261, 5816.272965879265, 5818.592698511064, 5821.534277257894, 5705.229793977843, 5746.827595172152, 5785.913211301834, 5795.130730390475, 5795.275590551181, 5759.337676167211, 5799.565032622486, 5806.042003069446, 5815.534757219412, 5851.151583020438, 4463.575960283768, 4475.552444755564, 4477.395551600557, 4483.21543729846, 4525.366448697185, 3928.332183528807, 3951.2295102454746, 3993.800309984489, 4018.1561872006623, 4055.959440405617, 5362.088444964365, 5373.462653734595, 5386.946130538723, 5391.676499410048, 5405.189221616711, 5742.052561327418, 5762.193292938992, 5765.279340082489, 5785.595008349375, 5789.652620842763, 5128.512791284822, 5231.346081739783, 5313.388960269541, 5340.172273297645, 5431.918521222185, 4866.270059491105, 4881.316615673809, 4894.461609222983, 4903.509649035068, 4928.950710492921, 5903.0555111182, 5924.6149000314845, 5941.079132734347, 5948.256467941507, 5964.165016897551, 5717.685527295872, 5823.505002074871, 5827.038538641077, 5905.291365036223, 5922.230110085661, 5959.642421454727, 5986.102084687332, 6005.429484198994, 6009.609375390585, 6017.909731354121, 5502.58730595199, 5721.485066344049, 5728.684922329312, 5733.31200255972, 5754.856128596819, 5725.312962444534, 5773.134029895549, 5860.150278209721, 5905.881882362414, 5907.9704601476715, 5722.856928576819, 5739.512141468022, 5742.08126699726, 5744.109663002241, 5746.770129194785, 5613.326400831763, 5645.322561292507, 5687.5449964001955, 5699.544036476989, 5699.601027928005, 5500.50495455395, 5513.8345849624575, 5514.944850551604, 5557.833265002057, 5595.160725891149, 5621.184928185472, 5653.434656534479, 5663.716814159358, 5692.459216374438, 5694.544436445157, 5356.839294821161, 5441.83674489766, 5537.36320323168, 5550.056490396723, 5564.165375193753], "unit": "score", "name": "dojo.html", "value": 5306.277311041259}, {"lowerIsBetter": false, "replicates": [568.3631142310146, 586.5835256967553, 606.6329870428391, 615.1756646094234, 617.9155581953671, 29493.852530737342, 37002.0, 37448.99999999996, 37626.0593485163, 37676.0, 41292.17415651693, 41739.16521669565, 41997.58002419975, 42064.0, 42159.36760948588, 8631.43895646784, 8751.037385887546, 8829.646814127427, 8873.3344999125, 8885.68900088497, 8647.394682372236, 8675.08911564286, 8721.084286149959, 8740.606672699712, 8750.518721470316, 8591.914080859175, 8736.8689469658, 8771.166739159802, 8771.605277762515, 8771.692990745325, 8694.652213911437, 8721.651133954634, 8728.25809806164, 8746.737597872074, 8780.604872780708, 8541.658333666646, 8675.479471231747, 8685.261752751023, 8720.563971801448, 8721.12788721129, 39634.60365396338, 39807.0, 39906.20187596232, 39935.201295974206, 40042.399364009565, 3353.4131526982924, 3528.929421411583, 3704.240630670733, 3796.14586717989, 4026.355783074694, 29017.0, 29098.41803163946, 29918.70081299181, 30106.54840177399, 30562.847185764153, 3933.0, 3947.50656167979, 3997.8400863965408, 4046.4941882264716, 4114.177164567069, 267356.0, 268143.0, 268248.0, 268271.0, 268959.0, 49505.25742113799, 54543.72728136413, 54807.451925480236, 55151.0, 55184.44815551873, 44050.33924491135, 58811.411885880596, 59606.70196649076, 59798.40201598015, 59811.700941495015, 13642.454301828015, 13885.236312002937, 13893.79159312611, 13900.374483148282, 13910.165390076629, 10675.359478431164, 10700.94649526763, 10702.464876756287, 10752.516136773864, 10773.946130269454, 17846.375376861746, 18552.350667726565, 18692.34576789806, 18692.813071869106, 18709.532261693566, 7859.205884410505, 7992.5204487730925, 8042.638081286239, 8060.153683863227, 8060.193980601893, 843.8734189871568, 845.0366582096415, 936.7704912296394, 994.5014589991528, 1078.0297732041226, 26190.0, 26792.19623411301, 26894.193174204804, 27706.584401234, 29007.41985160285, 954.6658669465631, 997.5162046407487, 1005.2711783956719, 1074.425182527344, 1150.2121047082608, 13554.864451355557, 13839.861601384058, 13871.583852484442, 13949.511767088306, 15228.923855380874, 241684.0, 243865.0, 244999.0, 245960.0, 246867.0, 46877.29684054742, 47505.28742068803, 47635.0, 47660.28509572359, 47689.28466073012, 1322.3454390076781, 1351.1892864281353, 1355.2342926246442, 1364.0724307471014, 1369.760291948925, 27668.723312766615, 28480.43039139247, 28764.137075887757, 28832.567511487763, 28863.42273154567, 45104.548954510035, 45119.32321015253, 45179.0, 45335.31997019982, 45465.0, 295233.0, 297075.0, 297951.0, 298092.0, 298205.0, 30027.249318767204, 30165.245868853453, 30345.39309213759, 30467.17196968189, 30481.695183048774, 40383.0, 41189.79405102955, 41716.374254386814, 42091.7895410521, 42283.15433691248, 34579.82710086534, 35184.64815351814, 35285.56345743902, 35405.82297088498, 35838.820805895804, 35024.64975350316, 35204.0, 35325.64674353327, 35385.82307088448, 35419.0, 34690.82654586711, 35081.82459087688, 35188.82405587956, 35231.47152792659, 35640.4653930186, 31216.843915780275, 31310.217244568157, 31594.842025790644, 32106.839465803456, 32307.0, 24062.0, 32207.677923220468, 33867.322653546296, 33984.830075849466, 34142.14644633805], "unit": "score", "name": "ext.html", "value": 18071.313899214623}, {"lowerIsBetter": false, "replicates": [352.7636483556018, 358.3084646631999, 358.89950813772145, 360.96209897960716, 360.96403322464533, 16509.752353714688, 17107.486775396726, 17549.824501754978, 17930.73103903441, 18265.178066986984, 10352.327098738595, 10765.730856728585, 14291.285435728223, 14332.713345733078, 14340.713185736306, 4882.926756098653, 5008.474110218429, 5197.454267301936, 5378.704171270579, 5391.083515802323, 4425.579569940866, 5326.493983071602, 5339.038972984861, 5367.141257398817, 5370.570354371641, 5619.662820230778, 5629.774809007635, 6600.93399066008, 6859.07402500661, 6862.0, 6687.331266873322, 6796.150481189851, 6805.829854253634, 6836.521443498982, 6839.794806155824, 6644.66776661165, 6648.734050637969, 6648.867022659568, 6654.633995130266, 6661.233958094785, 22090.77909220903, 22743.772562274495, 23229.186978455673, 23309.067637294487, 23339.76660233393, 2243.551289742058, 2299.1148407862925, 2323.2913961241816, 2348.7064116985375, 2361.622140457536, 13958.232297223649, 14157.292135393189, 14299.356528956117, 14457.927710361486, 14903.701925961528, 1869.6821540338176, 1885.27416944476, 1928.4021953194554, 1966.3314473079222, 1977.2881762565464, 65115.3488465114, 68531.65734171346, 68846.0, 68913.65543172252, 71140.6442967787, 14957.606782914681, 15149.318280677397, 15456.768148477782, 15480.922595386952, 15484.845151548565, 24457.633135502983, 24467.87766061194, 24475.632865507032, 24664.753352466603, 24707.135250266154, 8582.613782379807, 8592.398532102692, 8613.44012639189, 8682.175193356621, 8880.911190888137, 7234.421246300283, 7303.8539229216185, 7323.523970941872, 7351.669174887143, 7375.37309328713, 7644.0, 7663.770086897402, 7676.0, 7773.106092799288, 7904.249096335839, 1832.4777438429983, 2915.985420072886, 3121.8907338243052, 3122.3755248949847, 3128.3856311940162, 407.8225971702319, 411.2043196414947, 411.48358809693644, 796.5738329993426, 922.1193759959223, 10862.293950893325, 11041.282316649553, 11197.776044479066, 11276.548938042386, 16715.582110447336, 861.3238607692931, 862.0904945282787, 942.6936245720168, 974.133021610767, 977.9266555008403, 6572.901406478906, 9828.606855725833, 9865.1121399073, 9964.10323070927, 9974.700758977242, 526873.0, 534282.0, 537776.0, 543746.0, 554751.0, 80123.0, 81371.5931420339, 83248.58375708204, 83384.16615833764, 83814.48556543313, 1148.1102145836876, 1153.7288737146764, 1190.8273300371397, 1192.167459789194, 1193.146899966528, 15521.728921771723, 15573.922130389275, 15688.529344119695, 15818.841811582197, 15940.442084526985, 35221.82389088038, 35351.11622209465, 35386.46920296249, 35441.29117417689, 35570.822145889106, 42007.0, 43040.56959430491, 43260.783696081315, 43736.343954840064, 44470.555294447935, 9299.953500232727, 9673.274504412339, 9720.125188733047, 9772.706818795448, 9807.85288220663, 11485.0, 16816.663666726843, 16915.492535223962, 17454.91272543629, 17699.0, 13123.475060997453, 13196.538121165713, 13683.384247708678, 13702.931485342908, 13712.314384280946, 14427.42290308376, 14507.0, 14536.781948270573, 14773.0, 14989.175595342362, 13914.582562523141, 13966.930165349107, 14133.6466588332, 14246.643833904236, 14592.489262875748, 9580.760480987752, 9670.806583868423, 9713.70858874235, 9738.756531086496, 9865.506724663881, 10073.143782778547, 11984.340861252365, 13771.655708607364, 14175.432982680577, 14392.928035360175], "unit": "score", "name": "jquery.html", "value": 9460.106479028185}, {"lowerIsBetter": false, "replicates": [1424.6295963049606, 1483.4437086092719, 1594.7368684167113, 1602.4311369463846, 1723.1728770190316, 6661.933380666192, 6777.017332486799, 6805.523613347068, 7156.713731450743, 7210.170830354505, 7065.399441047517, 7205.207427183006, 7226.060612120417, 7269.5638261704335, 7323.853522929551, 2171.1206961180706, 2206.073449151352, 2214.22502124256, 2218.9889050554725, 2221.988995007268, 2221.2336743823357, 2226.4545186429345, 2292.151903795598, 2310.4685922237895, 2317.177402022283, 2225.6868447615902, 2226.92205772798, 2241.7758224177614, 2255.1994042115057, 2280.9657855132186, 2207.227470385368, 2226.8886555672234, 2233.140241007208, 2237.820974322067, 2249.0, 2251.909923603054, 2280.338701776483, 2285.8285628577923, 2289.828262880274, 2294.724633044029, 7276.308750668678, 7284.6721897514735, 7292.781216563459, 7311.963440182818, 7390.963045184793, 4376.540463251376, 4417.602415782563, 4428.247197976351, 4441.156180325728, 4445.777711114431, 3010.473167195754, 3037.39252149571, 3093.474109401407, 3123.9843800781077, 3129.8278594677286, 1006.9144122749575, 1011.2567263061644, 1031.9845202321972, 1035.321864178964, 1039.8856125826153, 9710.417374957455, 9785.363951343212, 9799.853002204973, 9815.263855210816, 9824.65613703517, 4045.474088368552, 4058.452108965311, 4080.3879418087527, 4093.4678491795876, 4103.138340948374, 8488.74533763988, 8546.487210767375, 8547.145285471528, 8554.957225213833, 8555.743327700178, 4448.243798554254, 4471.06107717383, 4477.888052798641, 4486.977565112219, 4488.483824360241, 3911.5501717302304, 3972.1459886124044, 4014.6186112319283, 4027.5368332641533, 4045.8988525287104, 3543.6102028776813, 3568.0, 3580.15866271426, 3594.0475773919934, 3624.8006359649944, 1132.399828091113, 1139.4986206069302, 1140.293018328625, 1142.0, 1145.450183911727, 975.7316737897135, 978.1392374710209, 982.832918403873, 1107.2360071550604, 1357.4027427931678, 6752.257251702309, 6772.187337519431, 6787.966060169668, 6826.8634627308165, 6840.6921688524135, 490.37966971780725, 504.84602196329735, 512.6975084700044, 515.2091539486945, 516.8320295903846, 5533.253010843565, 5547.694876781735, 5550.028744969614, 5590.8043218487155, 5595.244641973363, 7884.21157884207, 8026.036875574969, 8119.106898241189, 8380.287675547646, 8491.405601607828, 8452.535110568977, 8515.105913878953, 8529.74410767678, 8552.486850788848, 8563.229309362187, 6715.865682686319, 6775.525713200029, 6784.08414863987, 6789.321067893171, 6854.760083397157, 7009.824754381181, 7031.0, 7069.151701795818, 7073.71705131789, 7103.964480177773, 7439.256074392518, 7532.209118042527, 7548.433867460072, 7637.083549974039, 7813.804654883674, 7794.493357931717, 7915.722949696733, 7985.5208687478935, 7987.680492780224, 7994.200579941959, 6416.262129855127, 6608.801735947929, 6611.735530578723, 6641.435477984425, 6681.231658359156, 7070.540414873017, 7105.644717764195, 7114.288571142844, 7141.535800172972, 7176.928230717835, 6497.772577959938, 6619.0, 6700.296468870698, 6766.255711871789, 6787.490938179558, 6470.611763294218, 6533.509986751108, 6661.367170118831, 6734.797956061326, 6794.728210871707, 6610.272869984202, 6615.801525954229, 6638.5684930479365, 6645.734170633121, 6649.501287403561, 5981.551383646157, 6138.171346868295, 6144.477719393902, 6151.954167791576, 6156.507479401726, 6292.685365731787, 6299.527535434769, 6328.0, 6356.141920840627, 6365.204349456318], "unit": "score", "name": "mootools.html", "value": 4191.511692291103}, {"lowerIsBetter": false, "replicates": [334.6502904464834, 336.1461886807509, 338.41285369883235, 344.11219054838534, 346.27109933589793, 6346.14327065846, 6357.1417858589075, 6390.5207109466855, 6424.2290925089055, 6506.934930650692, 6341.746330146801, 6406.0, 6416.454601358879, 6429.260635026973, 6429.774957876475, 4827.806887724496, 4829.299751536025, 4858.149823780842, 4861.951380486203, 4874.926876096862, 4869.050535145648, 4875.049365373754, 4879.146149423855, 4882.926756098661, 4890.3642526471685, 4611.976940115312, 4615.561521655454, 4686.882827929312, 4688.5545873142, 4738.218193997986, 4662.673612847102, 4667.6265898728025, 4679.976600116977, 4682.6019788318035, 4691.8504966283135, 4074.0, 4090.4886889138857, 4097.262492751303, 4100.384942258685, 4103.425520427142, 5951.107333899907, 5954.047352423591, 5957.791477298274, 5966.0454327307425, 5970.537218381524, 5412.675239485643, 5432.809851655213, 5487.094629386146, 5496.1755736639425, 5501.889962200774, 6569.178852643419, 6604.3725846044545, 6608.537402381835, 6618.834529136762, 6619.278987463246, 4500.5274446183, 4500.752458614775, 4506.684532082755, 4508.368828364031, 4510.909781804346, 6970.093887794555, 7047.8590428191665, 7096.396806271473, 7107.857842843166, 7126.251743566902, 4650.906981860344, 4682.9765851171205, 4701.036287561042, 4703.0, 4704.811807527729, 4723.6929599575915, 4755.072760811678, 4761.928571071437, 4763.523647635278, 4768.690035147773, 5546.168074788814, 5554.833354999357, 5557.944420555824, 5560.7219639017885, 5570.136628822539, 6695.799126026227, 6700.162479690039, 6811.693473793691, 6813.693383797741, 6819.045333653293, 1659.983400166007, 1675.852041351678, 1680.0423758457562, 1680.7646929429889, 1683.8316168383064, 1104.9502772375263, 1111.0722546673458, 1114.587602587048, 1125.054953838763, 1128.610629332879, 6428.967855160694, 6441.967790161019, 6449.709763060673, 6457.354264573599, 6459.5143117083335, 7017.543859649107, 7019.613921234381, 7022.508424410345, 7024.754133605299, 7033.8241543960785, 6368.172137622172, 6372.7132279047555, 6420.261669907927, 6532.771353002717, 6534.346565343428, 3822.57951625321, 3843.3082045231567, 3853.344931361675, 3855.383138697795, 3858.3247931611854, 7409.0, 7415.480916335805, 7418.035655364876, 7437.367823735043, 7447.478676492594, 7103.934409838462, 7275.854482910312, 7289.307515785992, 7290.9635451822405, 7305.561666300039, 7336.5231259969, 7361.889571656429, 7367.410607151415, 7373.410127189812, 7388.815279617945, 6948.722051117898, 7067.681954312171, 7081.752138675121, 7086.858262834818, 7091.893621595784, 6979.092717946634, 7016.087908571853, 7017.333353331425, 7025.297470252934, 7033.577985320897, 7331.816704582215, 7350.117985841734, 7402.888956665762, 7419.4806363554035, 7419.962900185465, 4748.145333839942, 4778.235482322951, 4784.593309568726, 4792.281157826214, 4797.992421591365, 6902.0, 7088.468364872552, 7128.4653650977425, 7134.892976605459, 7143.6428178591905, 6891.9317505786685, 6899.793006209822, 6902.8619427612175, 6904.585724856524, 6906.723731050702, 6735.4274886635185, 6872.969054641843, 6892.207396149507, 6894.620795856075, 6910.170779506491, 6716.261211266659, 6752.155980502437, 6772.221194562689, 6772.55978361405, 6774.42417394527, 6839.076724642109, 6889.311068893071, 6929.133858267716, 6934.890417533171, 6935.306469353024, 6592.934070659232, 6677.699503522256, 6716.1604799400075, 6742.898856517254, 6779.35596118368], "unit": "score", "name": "prototype.html", "value": 5081.019497973563}, {"lowerIsBetter": false, "replicates": [855.0594346219158, 856.738694698117, 863.7408777366796, 864.6498168241865, 864.8270345930812, 13579.3210339483, 13843.446262149515, 13913.930430347835, 13925.37335819888, 13972.231527265996, 13440.865591344083, 13469.259190744506, 13515.662108447294, 13533.593992180226, 13579.0, 665.5507532415612, 678.1015154919727, 790.4466873188762, 812.2608426332039, 814.3973459639853, 813.6094674556217, 818.7339114787718, 820.2453742556833, 821.1870248454018, 823.197382552013, 859.1322764008365, 859.6131740716671, 860.9139086091373, 866.0343716755804, 868.1665601022994, 857.2884505860152, 858.4891989266439, 860.1398601398602, 861.9396642235046, 861.9956900215459, 631.2992578238152, 633.4267487923437, 634.3022675057446, 635.0, 635.0347471842773, 13442.260675662834, 13443.126196797177, 13537.729245415136, 13552.051356405056, 13559.932200339033, 12362.44369003397, 12831.87168128316, 12876.742465150644, 12935.935320323431, 13232.470701171942, 10163.898361016443, 10528.526216320284, 10539.63111291101, 10579.73550661232, 10641.467926603716, 3642.6721595056574, 3715.4241092630687, 3732.8320225589914, 3749.1189570450924, 3810.618938106195, 40748.0, 40908.590914090775, 40960.795196024126, 41225.38161927574, 41315.38026929599, 9585.952070239744, 9863.210943124534, 9971.601135954626, 10181.083702466814, 10207.234457415723, 17247.482575522754, 17257.741133883002, 17369.305227790748, 17416.47750567485, 18115.184816683282, 7666.693332266758, 7780.649870755829, 7782.221777822286, 7892.250236227549, 7966.522008679498, 4238.3430568261965, 4278.63631591312, 4318.265894797829, 4338.240807858612, 4372.715773474714, 3077.0, 3089.2276930767307, 3101.65881753007, 3103.0, 3110.9889285982144, 556.2074044486591, 577.8555361159711, 579.1168468086119, 591.7869566955892, 591.8017464149558, 641.6631268583938, 662.2218892800939, 667.4960404894274, 670.7920544631082, 677.3395938959475, 7902.24928631779, 7977.641006154737, 7978.880316795253, 7979.64346061171, 8136.1863813618165, 653.6960313454266, 662.3740565165969, 676.1649363036646, 682.8497730499282, 684.9589024658536, 3752.887413377603, 3773.471713960048, 3810.657040866335, 3911.0808959894403, 3930.7028680535354, 53107.46892531103, 53400.198997015075, 56062.15906761402, 57667.711661441426, 57910.7104464475, 48921.2661810066, 50027.749861250464, 50625.49374506208, 51022.0, 51638.74180629073, 42374.0, 45633.0, 45951.0, 46120.769396152806, 47103.0, 7675.232476752503, 7713.344365728976, 7915.84168316642, 8051.959740201261, 8107.3108785753875, 34748.0, 35162.648373515935, 35842.28315433729, 36038.8198059008, 36135.27729445344, 41854.79072604617, 42185.156296874506, 43976.78011609922, 45350.77324613356, 45784.54215457936, 10352.327098738559, 10376.584936602452, 10460.63387781424, 10497.422641754776, 10505.15958723285, 11652.242604230698, 11802.52789888395, 11994.220375675903, 12125.57560485414, 12171.573994910135, 9855.162311203629, 9958.900410995797, 10361.84457233127, 10481.528331224961, 10487.79024419492, 10533.104686101768, 10681.57273709043, 10900.0, 10956.397398143179, 11249.887501124884, 10086.0, 10158.288919775545, 10205.0, 10326.50263725149, 10512.632057877938, 8871.423357481743, 9342.53287335617, 9385.530723463937, 9417.952910235404, 9498.715038548855, 7926.762197134095, 8532.23209911111, 8581.442206256574, 8798.34012449056, 8919.241864441596], "unit": "score", "name": "yui.html", "value": 6199.906920184223}], "name": "dromaeo_css", "value": 7021.076379091551}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 112.0, 111.0, 111.0, 123.0, 111.0, 110.0, 109.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [156.0, 133.0, 154.0, 164.0, 129.0, 150.0, 163.0, 127.0, 169.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 164.0, 165.0, 162.0, 161.0, 160.0, 164.0, 167.0, 160.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 74.0, 71.0, 72.0, 72.0, 72.0, 132.0, 78.0, 71.0], "unit": "score", "name": "audio-fft", "value": 78.5}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 146.0, 93.0, 94.0, 99.0, 132.0, 93.0, 95.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 108.3}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 148.0, 147.0, 145.0, 148.0, 145.0, 146.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 103.0, 96.0, 95.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 97.0}, {"lowerIsBetter": true, "replicates": [61.0, 61.0, 62.0, 60.0, 62.0, 62.0, 63.0, 62.0, 56.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 60.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 69.0, 68.0, 67.0, 67.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 86.0, 85.0, 84.0, 84.0, 87.0, 85.0, 96.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [114.0, 123.0, 122.0, 120.0, 119.0, 124.0, 126.0, 116.0, 125.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.2}, {"lowerIsBetter": true, "replicates": [152.0, 147.0, 152.0, 148.0, 148.0, 147.0, 149.0, 150.0, 147.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 66.0, 68.0, 67.0, 65.0, 66.0, 67.0, 67.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1511.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.7175094712568], "unit": "score", "name": "Richards", "value": 214.31844199999998}, {"lowerIsBetter": false, "replicates": [187.30099269526127], "unit": "score", "name": "DeltaBlue", "value": 353.0040020000002}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1061.5711252653928], "unit": "score", "name": "RayTrace", "value": 697.0696380000003}, {"lowerIsBetter": false, "replicates": [719.9424046076314], "unit": "score", "name": "Earley", "value": 925.7171069999997}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [25450.0], "unit": "score", "name": "RegExp", "value": 35.79508840864438}, {"lowerIsBetter": false, "replicates": [805.1529790660226], "unit": "score", "name": "Splay", "value": 101.211822}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20784.343541710827}]} 19:07:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "20784.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1511.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "7021.08"}}} 19:07:31 INFO - Return code: 0 19:07:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:07:31 INFO - # TBPL SUCCESS # 19:07:31 INFO - Running post-action listener: _resource_record_post_action 19:07:31 INFO - Running post-run listener: _resource_record_post_run 19:07:32 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 0; Write bytes: 571207680; Read time: 0; Write time: 589932 19:07:32 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 244170752; Read time: 0; Write time: 354312 19:07:32 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 0; Write bytes: 323031040; Read time: 0; Write time: 234748 19:07:32 INFO - Running post-run listener: _upload_blobber_files 19:07:32 INFO - Blob upload gear active. 19:07:32 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:07:32 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 19:07:32 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'] 19:07:32 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 19:07:33 INFO - (blobuploader) - INFO - Open directory for files ... 19:07:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:07:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:07:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:34 INFO - (blobuploader) - INFO - Done attempting. 19:07:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:07:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:07:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:35 INFO - (blobuploader) - INFO - Done attempting. 19:07:35 INFO - (blobuploader) - INFO - Iteration through files over. 19:07:35 INFO - Return code: 0 19:07:35 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:07:35 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:07:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6b2a06e529a5bca5688ceabf27108f0151acf10a8816b4520bcedf08dac121bc3f06f8d4a1baeaff2b874ff287958aa23824214ea8d572c96acb1bf3e46b0291", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5af3669145969795d06987a46ffc53586a51fa8e5a03e4067f377853fb8885758c9a6ce436c4a1abe87ddb03b042861b39c49e65db90aab6ecffeb075cbae3fa"} 19:07:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:07:35 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:07:35 INFO - Contents: 19:07:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6b2a06e529a5bca5688ceabf27108f0151acf10a8816b4520bcedf08dac121bc3f06f8d4a1baeaff2b874ff287958aa23824214ea8d572c96acb1bf3e46b0291", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5af3669145969795d06987a46ffc53586a51fa8e5a03e4067f377853fb8885758c9a6ce436c4a1abe87ddb03b042861b39c49e65db90aab6ecffeb075cbae3fa"} 19:07:35 INFO - Copying logs to upload dir... 19:07:35 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.185345 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-12-22 19:07:34.772005) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 19:07:34.776154) ========= 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=928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753 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/6b2a06e529a5bca5688ceabf27108f0151acf10a8816b4520bcedf08dac121bc3f06f8d4a1baeaff2b874ff287958aa23824214ea8d572c96acb1bf3e46b0291", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5af3669145969795d06987a46ffc53586a51fa8e5a03e4067f377853fb8885758c9a6ce436c4a1abe87ddb03b042861b39c49e65db90aab6ecffeb075cbae3fa"} build_url:https://queue.taskcluster.net/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/k_2UDfEvSNmV8t1IOzr_jQ/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/6b2a06e529a5bca5688ceabf27108f0151acf10a8816b4520bcedf08dac121bc3f06f8d4a1baeaff2b874ff287958aa23824214ea8d572c96acb1bf3e46b0291", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5af3669145969795d06987a46ffc53586a51fa8e5a03e4067f377853fb8885758c9a6ce436c4a1abe87ddb03b042861b39c49e65db90aab6ecffeb075cbae3fa"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-22 19:07:34.801985) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:07:34.802378) ========= 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=928fd09416829678a2f67a56000001ac-1450837892.274370-1594490753 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-22 19:07:34.887835) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 19:07:34.888234) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-22 19:07:34.888668) ========= ========= Total master_lag: 0.24 =========