builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1450763604.73 results: success (0) buildid: 20151221193326 builduid: d76670e503ee462a86dbe4dec1f9a5fb revision: 6432606228940213ff615cb381597e96ff227483 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:24.729234) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:24.729679) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:24.729966) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006242 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:24.759792) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:24.760116) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:24.775319) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:24.775648) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004686 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:24.824423) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:24.824689) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:24.825078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:24.825343) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 21:53:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.5M=0s 2015-12-21 21:53:25 (40.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107243 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:24.945905) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:24.946231) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022388 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:24.996380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 21:53:24.996679) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 6432606228940213ff615cb381597e96ff227483 --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 6432606228940213ff615cb381597e96ff227483 --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=bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 21:53:25,808 truncating revision to first 12 chars 2015-12-21 21:53:25,808 Setting DEBUG logging. 2015-12-21 21:53:25,808 attempt 1/10 2015-12-21 21:53:25,808 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/643260622894?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 21:53:26,971 unpacking tar archive at: mozilla-inbound-643260622894/testing/mozharness/ program finished with exit code 0 elapsedTime=1.439489 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-21 21:53:26.448834) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:26.449149) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:26.459229) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:26.459577) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 21:53:26.460036) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-21 21:53:26.460319) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:53:27 INFO - MultiFileLogger online at 20151221 21:53:27 in /builds/slave/test-pgo 21:53:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 21:53:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 21:53:27 INFO - {'append_to_log': False, 21:53:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 21:53:27 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 21:53:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 21:53:27 INFO - 'branch': 'Mozilla-Inbound', 21:53:27 INFO - 'buildbot_json_path': 'buildprops.json', 21:53:27 INFO - 'config_files': ('talos/linux_config.py',), 21:53:27 INFO - 'default_actions': ('clobber', 21:53:27 INFO - 'read-buildbot-config', 21:53:27 INFO - 'download-and-extract', 21:53:27 INFO - 'populate-webroot', 21:53:27 INFO - 'create-virtualenv', 21:53:27 INFO - 'install', 21:53:27 INFO - 'run-tests'), 21:53:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:53:27 INFO - 'download_minidump_stackwalk': True, 21:53:27 INFO - 'download_symbols': 'ondemand', 21:53:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:53:27 INFO - 'tooltool.py': '/tools/tooltool.py', 21:53:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:53:27 INFO - '/tools/misc-python/virtualenv.py')}, 21:53:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:53:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:53:27 INFO - 'installer_path': 'installer.exe', 21:53:27 INFO - 'log_level': 'info', 21:53:27 INFO - 'log_name': 'talos', 21:53:27 INFO - 'log_to_console': True, 21:53:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:53:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:53:27 INFO - 'opt_config_files': (), 21:53:27 INFO - 'pip_index': False, 21:53:27 INFO - 'sps_profile': False, 21:53:27 INFO - 'sps_profile_interval': 0, 21:53:27 INFO - 'suite': 'dromaeojs', 21:53:27 INFO - 'system_bits': '64', 21:53:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:53:27 INFO - 'title': 'talos-linux64-ix-062', 21:53:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:53:27 INFO - 'use_talos_json': True, 21:53:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 21:53:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:53:27 INFO - 'work_dir': 'build'} 21:53:27 INFO - ##### 21:53:27 INFO - ##### Running clobber step. 21:53:27 INFO - ##### 21:53:27 INFO - Running pre-action listener: _resource_record_pre_action 21:53:27 INFO - Running main action method: clobber 21:53:27 INFO - rmtree: /builds/slave/test-pgo/build 21:53:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 21:53:28 INFO - Running post-action listener: _resource_record_post_action 21:53:28 INFO - ##### 21:53:28 INFO - ##### Running read-buildbot-config step. 21:53:28 INFO - ##### 21:53:28 INFO - Running pre-action listener: _resource_record_pre_action 21:53:28 INFO - Running main action method: read_buildbot_config 21:53:28 INFO - Using buildbot properties: 21:53:28 INFO - { 21:53:28 INFO - "project": "", 21:53:28 INFO - "product": "firefox", 21:53:28 INFO - "script_repo_revision": "production", 21:53:28 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 21:53:28 INFO - "repository": "", 21:53:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 21:53:28 INFO - "buildid": "20151221193326", 21:53:28 INFO - "pgo_build": "True", 21:53:28 INFO - "basedir": "/builds/slave/test-pgo", 21:53:28 INFO - "buildnumber": 1362, 21:53:28 INFO - "slavename": "talos-linux64-ix-062", 21:53:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:53:28 INFO - "platform": "ubuntu64_hw", 21:53:28 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 21:53:28 INFO - "branch": "mozilla-inbound", 21:53:28 INFO - "repo_path": "integration/mozilla-inbound", 21:53:28 INFO - "revision": "6432606228940213ff615cb381597e96ff227483", 21:53:28 INFO - "stage_platform": "linux64-pgo", 21:53:28 INFO - "builduid": "d76670e503ee462a86dbe4dec1f9a5fb", 21:53:28 INFO - "slavebuilddir": "test" 21:53:28 INFO - } 21:53:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 21:53:28 INFO - Running post-action listener: _resource_record_post_action 21:53:28 INFO - ##### 21:53:28 INFO - ##### Running download-and-extract step. 21:53:28 INFO - ##### 21:53:28 INFO - Running pre-action listener: _resource_record_pre_action 21:53:28 INFO - Running main action method: download_and_extract 21:53:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 21:53:28 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')]} 21:53:28 INFO - https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:53:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/test_packages.json 21:53:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/test_packages.json 21:53:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 21:53:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 21:53:32 INFO - Downloaded 1302 bytes. 21:53:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 21:53:32 INFO - Using the following test package requirements: 21:53:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:53:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:53:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:32 INFO - u'jsshell-linux-x86_64.zip'], 21:53:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:53:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:53:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:53:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:53:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:53:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 21:53:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 21:53:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:53:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:32 INFO - https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:53:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/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 21:53:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/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 21:53:33 INFO - Downloaded 23175545 bytes. 21:53:33 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 21:53:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:33 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 21:53:35 INFO - Return code: 0 21:53:35 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 21:53:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:35 INFO - https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:53:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/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 21:53:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/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 21:53:39 INFO - Downloaded 23175545 bytes. 21:53:39 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 21:53:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 21:53:39 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 21:53:40 INFO - Return code: 0 21:53: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')]} 21:53:40 INFO - https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:53:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:53:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:53:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/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 21:53:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/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 21:53:41 INFO - Downloaded 11132277 bytes. 21:53:41 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 21:53:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 21:53:41 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 21:53:41 INFO - Return code: 0 21:53:41 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')]} 21:53:41 INFO - https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:53:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:53:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:53:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/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 21:53:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/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 21:53:43 INFO - Downloaded 54940200 bytes. 21:53:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:53:43 INFO - mkdir: /builds/slave/test-pgo/properties 21:53:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 21:53:43 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 21:53:43 INFO - Contents: 21:53:43 INFO - build_url:https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 21:53:43 INFO - Running post-action listener: _resource_record_post_action 21:53:43 INFO - Running post-action listener: set_extra_try_arguments 21:53:43 INFO - ##### 21:53:43 INFO - ##### Running populate-webroot step. 21:53:43 INFO - ##### 21:53:43 INFO - Running pre-action listener: _resource_record_pre_action 21:53:43 INFO - Running main action method: populate_webroot 21:53:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:53:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:53:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:53:43 INFO - '--tppagecycles', 21:53:43 INFO - '7'], 21:53:43 INFO - 'tests': ['tsvgm']}}, 21:53:43 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:53:43 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:53:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:53:43 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:53:43 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:53:43 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:53:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:53:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:43 INFO - 'talos_options': ['--e10s'], 21:53:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:53:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:43 INFO - 'tests': ['damp', 'tps']}, 21:53:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:43 INFO - 'talos_options': ['--e10s'], 21:53:43 INFO - 'tests': ['damp', 'tps']}, 21:53:43 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:53:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:53:43 INFO - 'other': {'tests': ['a11yr', 21:53:43 INFO - 'ts_paint', 21:53:43 INFO - 'tpaint', 21:53:43 INFO - 'sessionrestore', 21:53:43 INFO - 'sessionrestore_no_auto_restore']}, 21:53:43 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:53:43 INFO - 'tests': ['a11yr', 21:53:43 INFO - 'ts_paint', 21:53:43 INFO - 'tpaint', 21:53:43 INFO - 'sessionrestore', 21:53:43 INFO - 'sessionrestore_no_auto_restore']}, 21:53:43 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:53:43 INFO - 'tests': ['a11yr', 21:53:43 INFO - 'ts_paint', 21:53:43 INFO - 'tpaint', 21:53:43 INFO - 'sessionrestore', 21:53:43 INFO - 'sessionrestore_no_auto_restore']}, 21:53:43 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:53:43 INFO - 'tests': ['a11yr', 21:53:43 INFO - 'ts_paint', 21:53:43 INFO - 'tpaint', 21:53:43 INFO - 'sessionrestore', 21:53:43 INFO - 'sessionrestore_no_auto_restore']}, 21:53:43 INFO - 'other_l64': {'tests': ['a11yr', 21:53:43 INFO - 'ts_paint', 21:53:43 INFO - 'tpaint', 21:53:43 INFO - 'sessionrestore', 21:53:43 INFO - 'sessionrestore_no_auto_restore']}, 21:53:43 INFO - 'other_nol64': {'tests': ['a11yr', 21:53:43 INFO - 'ts_paint', 21:53:43 INFO - 'tpaint', 21:53:43 INFO - 'sessionrestore', 21:53:43 INFO - 'sessionrestore_no_auto_restore']}, 21:53:43 INFO - 'svgr': {'tests': ['tsvgx', 21:53:43 INFO - 'tsvgr_opacity', 21:53:43 INFO - 'tart', 21:53:43 INFO - 'tscrollx', 21:53:43 INFO - 'cart']}, 21:53:43 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:53:43 INFO - 'tests': ['tsvgx', 21:53:43 INFO - 'tsvgr_opacity', 21:53:43 INFO - 'tart', 21:53:43 INFO - 'tscrollx', 21:53:43 INFO - 'cart']}, 21:53:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:43 INFO - 'tests': ['tp5o']}, 21:53:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:43 INFO - 'talos_options': ['--e10s'], 21:53:43 INFO - 'tests': ['tp5o']}, 21:53:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:43 INFO - 'talos_options': ['--xperf_path', 21:53:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:53:43 INFO - 'tests': ['tp5n']}, 21:53:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:53:43 INFO - 'talos_options': ['--e10s', 21:53:43 INFO - '--xperf_path', 21:53:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:53:43 INFO - 'tests': ['tp5n']}}, 21:53:43 INFO - 'talos.zip': {'path': '', 21:53:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:53:43 INFO - Running post-action listener: _resource_record_post_action 21:53:43 INFO - ##### 21:53:43 INFO - ##### Running create-virtualenv step. 21:53:43 INFO - ##### 21:53:43 INFO - Running pre-action listener: _resource_record_pre_action 21:53:43 INFO - Running main action method: create_virtualenv 21:53:43 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 21:53:43 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 21:53:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 21:53:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:53:43 INFO - Using real prefix '/usr' 21:53:43 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 21:53:43 INFO - Installing distribute.............................................................................................................................................................................................done. 21:53:45 INFO - Installing pip.................done. 21:53:45 INFO - Return code: 0 21:53:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 21:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:45 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 0x7ff1cb3b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e227f0>, '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 0x1d8e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', '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 21:53:45 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 21:53:45 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 21:53:45 INFO - Using env: {'DISPLAY': ':0', 21:53:45 INFO - 'HOME': '/home/cltbld', 21:53:45 INFO - 'LANG': 'en_US.UTF-8', 21:53:45 INFO - 'LANGUAGE': 'en_US:en', 21:53:45 INFO - 'LOGNAME': 'cltbld', 21:53:45 INFO - 'MAIL': '/var/mail/cltbld', 21:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:45 INFO - 'MOZ_NO_REMOTE': '1', 21:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:45 INFO - 'NO_EM_RESTART': '1', 21:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:53:45 INFO - 'PWD': '/builds/slave/test-pgo', 21:53:45 INFO - 'SHELL': '/bin/bash', 21:53:45 INFO - 'SHLVL': '1', 21:53:45 INFO - 'TERM': 'linux', 21:53:45 INFO - 'TMOUT': '86400', 21:53:45 INFO - 'USER': 'cltbld', 21:53:45 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', 21:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:45 INFO - '_': '/tools/buildbot/bin/python'} 21:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:45 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 21:53:46 INFO - Cleaning up... 21:53:46 INFO - Return code: 0 21:53:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 21:53:46 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')]} 21:53:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:46 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')]} 21:53:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:46 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 0x7ff1cb3b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e227f0>, '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 0x1d8e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', '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 21:53:46 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 21:53:46 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 21:53:46 INFO - Using env: {'DISPLAY': ':0', 21:53:46 INFO - 'HOME': '/home/cltbld', 21:53:46 INFO - 'LANG': 'en_US.UTF-8', 21:53:46 INFO - 'LANGUAGE': 'en_US:en', 21:53:46 INFO - 'LOGNAME': 'cltbld', 21:53:46 INFO - 'MAIL': '/var/mail/cltbld', 21:53:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:46 INFO - 'MOZ_NO_REMOTE': '1', 21:53:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:46 INFO - 'NO_EM_RESTART': '1', 21:53:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:53:46 INFO - 'PWD': '/builds/slave/test-pgo', 21:53:46 INFO - 'SHELL': '/bin/bash', 21:53:46 INFO - 'SHLVL': '1', 21:53:46 INFO - 'TERM': 'linux', 21:53:46 INFO - 'TMOUT': '86400', 21:53:46 INFO - 'USER': 'cltbld', 21:53:46 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', 21:53:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:46 INFO - '_': '/tools/buildbot/bin/python'} 21:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:46 INFO - Downloading/unpacking psutil>=0.7.1 21:53:46 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 21:53:46 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 21:53:46 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 21:53:46 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 21:53:46 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 21:53:46 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 21:53:47 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 21:53:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:53:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 21:53:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:53:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:53:48 INFO - Installing collected packages: psutil 21:53:48 INFO - Running setup.py install for psutil 21:53:48 INFO - building 'psutil._psutil_linux' extension 21:53:48 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 21:53:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:53:48 INFO - building 'psutil._psutil_posix' extension 21:53:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:53:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:53:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:53:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:53:48 INFO - Successfully installed psutil 21:53:48 INFO - Cleaning up... 21:53:48 INFO - Return code: 0 21:53:48 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 21:53:48 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')]} 21:53:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:48 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')]} 21:53:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:48 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 0x7ff1cb3b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e227f0>, '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 0x1d8e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', '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 21:53:48 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 21:53:48 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 21:53:48 INFO - Using env: {'DISPLAY': ':0', 21:53:48 INFO - 'HOME': '/home/cltbld', 21:53:48 INFO - 'LANG': 'en_US.UTF-8', 21:53:48 INFO - 'LANGUAGE': 'en_US:en', 21:53:48 INFO - 'LOGNAME': 'cltbld', 21:53:48 INFO - 'MAIL': '/var/mail/cltbld', 21:53:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:48 INFO - 'MOZ_NO_REMOTE': '1', 21:53:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:48 INFO - 'NO_EM_RESTART': '1', 21:53:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:53:48 INFO - 'PWD': '/builds/slave/test-pgo', 21:53:48 INFO - 'SHELL': '/bin/bash', 21:53:48 INFO - 'SHLVL': '1', 21:53:48 INFO - 'TERM': 'linux', 21:53:48 INFO - 'TMOUT': '86400', 21:53:48 INFO - 'USER': 'cltbld', 21:53:48 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', 21:53:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:48 INFO - '_': '/tools/buildbot/bin/python'} 21:53:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:53:48 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 21:53:48 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 21:53:48 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 21:53:48 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 21:53:48 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 21:53:48 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 21:53:50 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:53:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:53:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:53:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:53:50 INFO - Installing collected packages: mozsystemmonitor 21:53:50 INFO - Running setup.py install for mozsystemmonitor 21:53:50 INFO - Successfully installed mozsystemmonitor 21:53:50 INFO - Cleaning up... 21:53:50 INFO - Return code: 0 21:53:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 21:53:50 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')]} 21:53:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:50 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')]} 21:53:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:50 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 0x7ff1cb3b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e227f0>, '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 0x1d8e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', '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 21:53:50 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 21:53:50 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 21:53:50 INFO - Using env: {'DISPLAY': ':0', 21:53:50 INFO - 'HOME': '/home/cltbld', 21:53:50 INFO - 'LANG': 'en_US.UTF-8', 21:53:50 INFO - 'LANGUAGE': 'en_US:en', 21:53:50 INFO - 'LOGNAME': 'cltbld', 21:53:50 INFO - 'MAIL': '/var/mail/cltbld', 21:53:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:50 INFO - 'MOZ_NO_REMOTE': '1', 21:53:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:50 INFO - 'NO_EM_RESTART': '1', 21:53:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:53:50 INFO - 'PWD': '/builds/slave/test-pgo', 21:53:50 INFO - 'SHELL': '/bin/bash', 21:53:50 INFO - 'SHLVL': '1', 21:53:50 INFO - 'TERM': 'linux', 21:53:50 INFO - 'TMOUT': '86400', 21:53:50 INFO - 'USER': 'cltbld', 21:53:50 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', 21:53:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:50 INFO - '_': '/tools/buildbot/bin/python'} 21:53:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:50 INFO - Downloading/unpacking blobuploader==1.2.4 21:53:50 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 21:53:50 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 21:53:50 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 21:53:50 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 21:53:50 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 21:53:50 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 21:53:52 INFO - Downloading blobuploader-1.2.4.tar.gz 21:53:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:53:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:53:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:53:52 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 21:53:52 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 21:53:52 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 21:53:52 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 21:53:52 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 21:53:52 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 21:53:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:53:52 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 21:53:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:53:52 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 21:53:52 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 21:53:52 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 21:53:52 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 21:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:53:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:53:53 INFO - Downloading docopt-0.6.1.tar.gz 21:53:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:53:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 21:53:53 INFO - Installing collected packages: blobuploader, requests, docopt 21:53:53 INFO - Running setup.py install for blobuploader 21:53:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:53:53 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 21:53:53 INFO - Running setup.py install for requests 21:53:53 INFO - Running setup.py install for docopt 21:53:53 INFO - Successfully installed blobuploader requests docopt 21:53:53 INFO - Cleaning up... 21:53:53 INFO - Return code: 0 21:53:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:53 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 0x7ff1cb3b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e227f0>, '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 0x1d8e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', '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 21:53:53 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 21:53:53 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 21:53:53 INFO - Using env: {'DISPLAY': ':0', 21:53:53 INFO - 'HOME': '/home/cltbld', 21:53:53 INFO - 'LANG': 'en_US.UTF-8', 21:53:53 INFO - 'LANGUAGE': 'en_US:en', 21:53:53 INFO - 'LOGNAME': 'cltbld', 21:53:53 INFO - 'MAIL': '/var/mail/cltbld', 21:53:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:53 INFO - 'MOZ_NO_REMOTE': '1', 21:53:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:53 INFO - 'NO_EM_RESTART': '1', 21:53:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:53:53 INFO - 'PWD': '/builds/slave/test-pgo', 21:53:53 INFO - 'SHELL': '/bin/bash', 21:53:53 INFO - 'SHLVL': '1', 21:53:53 INFO - 'TERM': 'linux', 21:53:53 INFO - 'TMOUT': '86400', 21:53:53 INFO - 'USER': 'cltbld', 21:53:53 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', 21:53:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:53 INFO - '_': '/tools/buildbot/bin/python'} 21:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:53:54 INFO - Running setup.py (path:/tmp/pip-bQUzc_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:53:54 INFO - Running setup.py (path:/tmp/pip-lo1hzc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:53:54 INFO - Running setup.py (path:/tmp/pip-SdYE4F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:53:54 INFO - Running setup.py (path:/tmp/pip-uBK3_E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:53:54 INFO - Running setup.py (path:/tmp/pip-DoKjsA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:53:54 INFO - Running setup.py (path:/tmp/pip-TJpEF6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:53:54 INFO - Running setup.py (path:/tmp/pip-TvSAJ8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:53:54 INFO - Running setup.py (path:/tmp/pip-gEnmNF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:53:54 INFO - Running setup.py (path:/tmp/pip-dLsDJ0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:53:54 INFO - Running setup.py (path:/tmp/pip-barsCT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:53:54 INFO - Running setup.py (path:/tmp/pip-PflZbv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:53:54 INFO - Running setup.py (path:/tmp/pip-wYzNTT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:53:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:53:54 INFO - Running setup.py (path:/tmp/pip-WlpRiy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:53:55 INFO - Running setup.py (path:/tmp/pip-w5tKXT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:53:55 INFO - Running setup.py (path:/tmp/pip-xTL6DD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:53:55 INFO - Running setup.py (path:/tmp/pip-iAsy9G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:53:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:53:55 INFO - Running setup.py (path:/tmp/pip-ScxUnC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:53:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:53:55 INFO - Running setup.py install for manifestparser 21:53:55 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 21:53:55 INFO - Running setup.py install for mozcrash 21:53:55 INFO - Running setup.py install for mozdebug 21:53:55 INFO - Running setup.py install for mozdevice 21:53:55 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 21:53:55 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 21:53:55 INFO - Running setup.py install for mozfile 21:53:55 INFO - Running setup.py install for mozhttpd 21:53:55 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 21:53:55 INFO - Running setup.py install for mozinfo 21:53:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 21:53:56 INFO - Running setup.py install for mozInstall 21:53:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 21:53:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 21:53:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 21:53:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 21:53:56 INFO - Running setup.py install for mozleak 21:53:56 INFO - Running setup.py install for mozlog 21:53:56 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 21:53:56 INFO - Running setup.py install for moznetwork 21:53:56 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 21:53:56 INFO - Running setup.py install for mozprocess 21:53:56 INFO - Running setup.py install for mozprofile 21:53:56 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 21:53:56 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 21:53:56 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 21:53:56 INFO - Running setup.py install for mozrunner 21:53:56 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 21:53:56 INFO - Running setup.py install for mozscreenshot 21:53:56 INFO - Running setup.py install for moztest 21:53:56 INFO - Running setup.py install for mozversion 21:53:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 21:53:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:53:57 INFO - Cleaning up... 21:53:57 INFO - Return code: 0 21:53:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:53:57 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 0x7ff1cb3b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e227f0>, '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 0x1d8e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', '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 21:53:57 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 21:53:57 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 21:53:57 INFO - Using env: {'DISPLAY': ':0', 21:53:57 INFO - 'HOME': '/home/cltbld', 21:53:57 INFO - 'LANG': 'en_US.UTF-8', 21:53:57 INFO - 'LANGUAGE': 'en_US:en', 21:53:57 INFO - 'LOGNAME': 'cltbld', 21:53:57 INFO - 'MAIL': '/var/mail/cltbld', 21:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:53:57 INFO - 'MOZ_NO_REMOTE': '1', 21:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:53:57 INFO - 'NO_EM_RESTART': '1', 21:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:53:57 INFO - 'PWD': '/builds/slave/test-pgo', 21:53:57 INFO - 'SHELL': '/bin/bash', 21:53:57 INFO - 'SHLVL': '1', 21:53:57 INFO - 'TERM': 'linux', 21:53:57 INFO - 'TMOUT': '86400', 21:53:57 INFO - 'USER': 'cltbld', 21:53:57 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', 21:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:53:57 INFO - '_': '/tools/buildbot/bin/python'} 21:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:53:57 INFO - Running setup.py (path:/tmp/pip-jVj9Mc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 21:53:57 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)) 21:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:53:57 INFO - Running setup.py (path:/tmp/pip-vcF0vC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 21:53:57 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)) 21:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:53:57 INFO - Running setup.py (path:/tmp/pip-1sdEbG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 21:53:57 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)) 21:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:53:57 INFO - Running setup.py (path:/tmp/pip-pCQqTS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 21:53:57 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)) 21:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 21:53:57 INFO - Running setup.py (path:/tmp/pip-kHqjlU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 21:53:57 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)) 21:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:53:57 INFO - Running setup.py (path:/tmp/pip-cb1MZY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 21:53:57 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)) 21:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:53:57 INFO - Running setup.py (path:/tmp/pip-oCILTm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 21:53:57 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)) 21:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:53:57 INFO - Running setup.py (path:/tmp/pip-P5Ps2L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 21:53:57 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)) 21:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 21:53:57 INFO - Running setup.py (path:/tmp/pip-EDx8OD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 21:53:57 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)) 21:53:57 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 21:53:57 INFO - Running setup.py (path:/tmp/pip-U51tqE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 21:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:53:58 INFO - Running setup.py (path:/tmp/pip-rYqLk0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 21:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 21:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:53:58 INFO - Running setup.py (path:/tmp/pip-TOR7SU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 21:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 21:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:53:58 INFO - Running setup.py (path:/tmp/pip-MYTSud-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 21:53:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 21:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:53:58 INFO - Running setup.py (path:/tmp/pip-4IxFCB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 21:53:58 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)) 21:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:53:58 INFO - Running setup.py (path:/tmp/pip-amAjIR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 21:53:58 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)) 21:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 21:53:58 INFO - Running setup.py (path:/tmp/pip-vMelO4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 21:53:58 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)) 21:53:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 21:53:58 INFO - Running setup.py (path:/tmp/pip-wM_BPC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 21:53:58 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)) 21:53:58 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)) 21:53:58 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)) 21:53:58 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)) 21:53:58 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)) 21:53:58 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)) 21:53:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 21:53:58 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 21:53:58 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 21:53:58 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 21:53:58 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 21:53:58 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 21:53:58 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 21:54:00 INFO - Downloading blessings-1.5.1.tar.gz 21:54:00 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 21:54:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 21:54:00 INFO - Installing collected packages: blessings 21:54:00 INFO - Running setup.py install for blessings 21:54:00 INFO - Successfully installed blessings 21:54:00 INFO - Cleaning up... 21:54:00 INFO - Return code: 0 21:54:00 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 21:54:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:54:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:54:00 INFO - Reading from file tmpfile_stdout 21:54:00 INFO - Current package versions: 21:54:00 INFO - argparse == 1.2.1 21:54:00 INFO - blessings == 1.5.1 21:54:00 INFO - blobuploader == 1.2.4 21:54:00 INFO - docopt == 0.6.1 21:54:00 INFO - manifestparser == 1.1 21:54:00 INFO - mozInstall == 1.12 21:54:00 INFO - mozcrash == 0.16 21:54:00 INFO - mozdebug == 0.1 21:54:00 INFO - mozdevice == 0.47 21:54:00 INFO - mozfile == 1.2 21:54:00 INFO - mozhttpd == 0.7 21:54:00 INFO - mozinfo == 0.9 21:54:00 INFO - mozleak == 0.1 21:54:00 INFO - mozlog == 3.1 21:54:00 INFO - moznetwork == 0.27 21:54:00 INFO - mozprocess == 0.22 21:54:00 INFO - mozprofile == 0.28 21:54:00 INFO - mozrunner == 6.11 21:54:00 INFO - mozscreenshot == 0.1 21:54:00 INFO - mozsystemmonitor == 0.0 21:54:00 INFO - moztest == 0.7 21:54:00 INFO - mozversion == 1.4 21:54:00 INFO - psutil == 3.1.1 21:54:00 INFO - requests == 1.2.3 21:54:00 INFO - wsgiref == 0.1.2 21:54:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 21:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:00 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 0x7ff1cb3b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e227f0>, '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 0x1d8e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', '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 21:54:00 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 21:54:00 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 21:54:00 INFO - Using env: {'DISPLAY': ':0', 21:54:00 INFO - 'HOME': '/home/cltbld', 21:54:00 INFO - 'LANG': 'en_US.UTF-8', 21:54:00 INFO - 'LANGUAGE': 'en_US:en', 21:54:00 INFO - 'LOGNAME': 'cltbld', 21:54:00 INFO - 'MAIL': '/var/mail/cltbld', 21:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:00 INFO - 'MOZ_NO_REMOTE': '1', 21:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:00 INFO - 'NO_EM_RESTART': '1', 21:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:00 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:00 INFO - 'SHELL': '/bin/bash', 21:54:00 INFO - 'SHLVL': '1', 21:54:00 INFO - 'TERM': 'linux', 21:54:00 INFO - 'TMOUT': '86400', 21:54:00 INFO - 'USER': 'cltbld', 21:54:00 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', 21:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:00 INFO - '_': '/tools/buildbot/bin/python'} 21:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:00 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)) 21:54:00 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)) 21:54:00 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)) 21:54:00 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)) 21:54:00 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)) 21:54:00 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)) 21:54:00 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)) 21:54:00 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)) 21:54:00 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)) 21:54:00 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)) 21:54:00 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)) 21:54:00 INFO - Cleaning up... 21:54:00 INFO - Return code: 0 21:54:00 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 21:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:00 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 0x7ff1cb3b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e227f0>, '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 0x1d8e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', '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 21:54:00 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 21:54:00 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 21:54:00 INFO - Using env: {'DISPLAY': ':0', 21:54:00 INFO - 'HOME': '/home/cltbld', 21:54:00 INFO - 'LANG': 'en_US.UTF-8', 21:54:00 INFO - 'LANGUAGE': 'en_US:en', 21:54:00 INFO - 'LOGNAME': 'cltbld', 21:54:00 INFO - 'MAIL': '/var/mail/cltbld', 21:54:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:00 INFO - 'MOZ_NO_REMOTE': '1', 21:54:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:00 INFO - 'NO_EM_RESTART': '1', 21:54:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:00 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:00 INFO - 'SHELL': '/bin/bash', 21:54:00 INFO - 'SHLVL': '1', 21:54:00 INFO - 'TERM': 'linux', 21:54:00 INFO - 'TMOUT': '86400', 21:54:00 INFO - 'USER': 'cltbld', 21:54:00 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', 21:54:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:00 INFO - '_': '/tools/buildbot/bin/python'} 21:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:01 INFO - Downloading/unpacking jsonschema 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:54:02 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 21:54:02 INFO - Downloading/unpacking functools32 (from jsonschema) 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54: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 21:54:02 INFO - Downloading functools32-3.2.3-2.tar.gz 21:54:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 21:54:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 21:54:03 INFO - warning: no files found matching '*.txt' 21:54:03 INFO - no previously-included directories found matching 'build' 21:54:03 INFO - no previously-included directories found matching 'dist' 21:54:03 INFO - no previously-included directories found matching '.git*' 21:54:03 INFO - Installing collected packages: jsonschema, functools32 21:54:03 INFO - Running setup.py install for functools32 21:54:03 INFO - warning: no files found matching '*.txt' 21:54:03 INFO - no previously-included directories found matching 'build' 21:54:03 INFO - no previously-included directories found matching 'dist' 21:54:03 INFO - no previously-included directories found matching '.git*' 21:54:03 INFO - Successfully installed jsonschema functools32 21:54:03 INFO - Cleaning up... 21:54:03 INFO - Return code: 0 21:54:03 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 21:54:03 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')]} 21:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:03 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')]} 21:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:54:03 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 0x7ff1cb3b0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cc18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d90230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e227f0>, '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 0x1d8e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e760>, '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': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', '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 21:54:03 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 21:54:03 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 21:54:03 INFO - Using env: {'DISPLAY': ':0', 21:54:03 INFO - 'HOME': '/home/cltbld', 21:54:03 INFO - 'LANG': 'en_US.UTF-8', 21:54:03 INFO - 'LANGUAGE': 'en_US:en', 21:54:03 INFO - 'LOGNAME': 'cltbld', 21:54:03 INFO - 'MAIL': '/var/mail/cltbld', 21:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:03 INFO - 'MOZ_NO_REMOTE': '1', 21:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:03 INFO - 'NO_EM_RESTART': '1', 21:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:03 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:03 INFO - 'SHELL': '/bin/bash', 21:54:03 INFO - 'SHLVL': '1', 21:54:03 INFO - 'TERM': 'linux', 21:54:03 INFO - 'TMOUT': '86400', 21:54:03 INFO - 'USER': 'cltbld', 21:54:03 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', 21:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:03 INFO - '_': '/tools/buildbot/bin/python'} 21:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:54:03 INFO - Downloading/unpacking flake8 21:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:54:05 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 21:54:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:54:05 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 21:54:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:05 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 21:54:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:54:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:54:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 21:54:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 21:54:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:54:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:54:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:54:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:54:05 INFO - no previously-included directories found matching 'docs/_build' 21:54:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:54:05 INFO - Running setup.py install for pep8 21:54:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:54:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:54:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:54:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:54:06 INFO - no previously-included directories found matching 'docs/_build' 21:54:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 21:54:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:54:06 INFO - Cleaning up... 21:54:06 INFO - Return code: 0 21:54:06 INFO - Running post-action listener: _resource_record_post_action 21:54:06 INFO - Running post-action listener: _start_resource_monitoring 21:54:06 INFO - Starting resource monitoring. 21:54:06 INFO - ##### 21:54:06 INFO - ##### Running install step. 21:54:06 INFO - ##### 21:54:06 INFO - Running pre-action listener: _resource_record_pre_action 21:54:06 INFO - Running main action method: install 21:54:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 21:54:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 21:54:06 INFO - Reading from file tmpfile_stdout 21:54:06 INFO - Detecting whether we're running mozinstall >=1.0... 21:54:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 21:54:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 21:54:06 INFO - Reading from file tmpfile_stdout 21:54:06 INFO - Output received: 21:54:06 INFO - Usage: mozinstall [options] installer 21:54:06 INFO - Options: 21:54:06 INFO - -h, --help show this help message and exit 21:54:06 INFO - -d DEST, --destination=DEST 21:54:06 INFO - Directory to install application into. [default: 21:54:06 INFO - "/builds/slave/test-pgo"] 21:54:06 INFO - --app=APP Application being installed. [default: firefox] 21:54:06 INFO - mkdir: /builds/slave/test-pgo/build/application 21:54:06 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'] 21:54:06 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 21:54:22 INFO - Reading from file tmpfile_stdout 21:54:22 INFO - Output received: 21:54:22 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 21:54:22 INFO - Running post-action listener: _resource_record_post_action 21:54:22 INFO - ##### 21:54:22 INFO - ##### Running run-tests step. 21:54:22 INFO - ##### 21:54:22 INFO - Running pre-action listener: _resource_record_pre_action 21:54:22 INFO - Running main action method: run_tests 21:54:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 21:54:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 21:54:22 INFO - Python 2.7.3 21:54:22 INFO - Return code: 0 21:54:22 INFO - grabbing minidump binary from tooltool 21:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:54:22 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 0x1e227f0>, '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 0x1d8e2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d8e760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 21:54:22 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 21:54:22 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 21:54:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:54:22 INFO - Return code: 0 21:54:22 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 21:54:22 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 21:54:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 21:54:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 21:54:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 21:54:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 21:54:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 21:54:23 INFO - Return code: 0 21:54:23 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 21:54:23 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 --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 21:54:23 INFO - Using env: {'DISPLAY': ':0', 21:54:23 INFO - 'HOME': '/home/cltbld', 21:54:23 INFO - 'LANG': 'en_US.UTF-8', 21:54:23 INFO - 'LANGUAGE': 'en_US:en', 21:54:23 INFO - 'LOGNAME': 'cltbld', 21:54:23 INFO - 'MAIL': '/var/mail/cltbld', 21:54:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:54:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 21:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:54:23 INFO - 'MOZ_NO_REMOTE': '1', 21:54:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 21:54:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:54:23 INFO - 'NO_EM_RESTART': '1', 21:54:23 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 21:54:23 INFO - 'PWD': '/builds/slave/test-pgo', 21:54:23 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 21:54:23 INFO - 'SHELL': '/bin/bash', 21:54:23 INFO - 'SHLVL': '1', 21:54:23 INFO - 'TERM': 'linux', 21:54:23 INFO - 'TMOUT': '86400', 21:54:23 INFO - 'USER': 'cltbld', 21:54:23 INFO - 'XDG_SESSION_COOKIE': 'bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478', 21:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:54:23 INFO - '_': '/tools/buildbot/bin/python'} 21:54:23 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', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:54:23 INFO - mozversion application_buildid: 20151221193326 21:54:23 INFO - mozversion application_changeset: 6432606228940213ff615cb381597e96ff227483 21:54:23 INFO - mozversion application_display_name: Nightly 21:54:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:54:23 INFO - mozversion application_name: Firefox 21:54:23 INFO - mozversion application_remotingname: firefox 21:54:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:54:23 INFO - mozversion application_vendor: Mozilla 21:54:23 INFO - mozversion application_version: 46.0a1 21:54:23 INFO - mozversion platform_buildid: 20151221193326 21:54:23 INFO - mozversion platform_changeset: 6432606228940213ff615cb381597e96ff227483 21:54:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 21:54:23 INFO - mozversion platform_version: 46.0a1 21:54:23 INFO - using testdate: 1450763663 21:54:23 INFO - actual date: 1450763663 21:54:23 INFO - starting webserver on 'localhost:41729' 21:54:23 INFO - SUITE-START | Running 3 tests 21:54:23 INFO - TEST-START | dromaeo_css 21:54:23 INFO - operating with platform_type : linux_ 21:54:23 INFO - Initialising browser for dromaeo_css test... 21:54:23 INFO - TEST-INFO | started process 27488 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVFFPCo/profile http://localhost:41729/getInfo.html) 21:54:27 INFO - PROCESS | 27488 | __metrics Screen width/height:1600/1200 21:54:27 INFO - PROCESS | 27488 | colorDepth:24 21:54:27 INFO - PROCESS | 27488 | Browser inner width/height: 1024/697 21:54:27 INFO - PROCESS | 27488 | __metrics 21:54:27 INFO - PROCESS | 27488 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:54:28 INFO - PROCESS | 27488 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:54:28 INFO - TEST-INFO | 27488: exit 0 21:54:28 INFO - Browser initialized. 21:54:28 INFO - Running cycle 1/1 for dromaeo_css test... 21:54:28 INFO - TEST-INFO | started process 27586 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVFFPCo/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:54:40 INFO - PROCESS | 27586 | RSS: Main: 149708800 21:54:40 INFO - PROCESS | 27586 | 21:55:32 INFO - PROCESS | 27586 | 1450763732214 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] 21:57:40 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:41729/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41729/tests/dromaeo/cssquery-ext.html) 21:57:42 INFO - PROCESS | 27586 | RSS: Main: 256229376 21:57:42 INFO - PROCESS | 27586 | 22:00:44 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:41729/tests/dromaeo/cssquery-ext.html (next: http://localhost:41729/tests/dromaeo/cssquery-jquery.html) 22:00:44 INFO - PROCESS | 27586 | RSS: Main: 235102208 22:00:44 INFO - PROCESS | 27586 | 22:03:46 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:41729/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41729/tests/dromaeo/cssquery-mootools.html) 22:03:47 INFO - PROCESS | 27586 | RSS: Main: 232316928 22:03:47 INFO - PROCESS | 27586 | 22:06:49 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:41729/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41729/tests/dromaeo/cssquery-prototype.html) 22:06:49 INFO - PROCESS | 27586 | RSS: Main: 212037632 22:06:49 INFO - PROCESS | 27586 | 22:09:52 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:41729/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41729/tests/dromaeo/cssquery-yui.html) 22:09:52 INFO - PROCESS | 27586 | RSS: Main: 215187456 22:09:52 INFO - PROCESS | 27586 | 22:12:55 INFO - PROCESS | 27586 | Cycle 1(1): loaded http://localhost:41729/tests/dromaeo/cssquery-yui.html (next: http://localhost:41729/tests/dromaeo/cssquery-dojo.html) 22:12:55 INFO - PROCESS | 27586 | RSS: Main: 257548288 22:12:55 INFO - PROCESS | 27586 | 22:12:55 INFO - PROCESS | 27586 | __start_tp_report 22:12:55 INFO - PROCESS | 27586 | _x_x_mozilla_page_load 22:12:55 INFO - PROCESS | 27586 | _x_x_mozilla_page_load_details 22:12:55 INFO - PROCESS | 27586 | |i|pagename|runs| 22:12:55 INFO - PROCESS | 27586 | |0;dojo.html;3096.7677424193184;3131.514615234639;3201.6638252983435;3202.9999999999986;3227.7256433203183;5096.515830996059;5227.424983251849;5289.497497737713;5349.331333583302;5387.703676297807;5251.396089449705;5267.52592266696;5310.256564081032;5323.547498462625;5378.569714422846;4770.260609605517;4788.281757736333;4790.520947905216;4809.350737650425;4896.510348965111;4838.709677419349;4911.165101932662;4915.459299477055;4943.3172286646495;5000.299958005882;4721.197396442596;4743.0988112258565;4842.370491836074;4847.757612119415;4908.705477671333;4828.299896515021;4843.782029808667;4851.951480485185;4854.029194161182;4866.270059491069;4794.640401969867;4803.615710743167;4811.735354555498;4819.1325561398935;4866.367372241586;5029.673071250357;5133.383993920716;5142.897142057138;5146.871328216787;5151.04705629456;5658.773649054033;5721.5708821838525;5731.713414329267;5779.104238842986;5785.942140578582;5768.913466298009;5781.913271300934;5805.796797112123;5808.361080281165;5809.2447981762525;5113.693178409233;5216.66091704038;5408.864778380533;5427.158790387457;5430;5697.202391665171;5705.5150312223095;5721.4278572143285;5727.255456790591;5765.88468230633;5554.944450555524;5556.638818476786;5559.249501317351;5609.4390560943575;5610.691411972299;5516.806911758069;5597.188407680864;5620.016497112989;5651.813119244923;5711.657300561979;5555.916661250085;5585.748641311069;5611.579131565068;5627.943720562824;5629.521490673257;5619.7471113799975;5620.297462817148;5620.91568626471;5620.971895140498;5624.690642014729;4212.684048696298;4311.396404503372;4373.278409062469;4374.081442897027;4418.889527761831;3831.4061320495366;3872.7482713623526;3873.65137137659;3910.7262491625315;3916.1971795782365;5325.121354976385;5328.200769884548;5329.840104796862;5330.493603107699;5375.919361209585;5482.068048431776;5599.468050535274;5601.187827765033;5691.345495268014;5709.914351284734;5328.49379308965;5440.700761458158;5447.918281225785;5458.235846981426;5461.890762184734;4966.205407134841;4976.253561965662;4999.0501804657;5002.274670172805;5032.622553308516;5685.744141513559;5746.42535746422;5755.597108202385;5756.42435756421;5764.74058667361;5450.672959622435;5555.166724991283;5576.609637325349;5604.551635869039;5780.624259423124;5710.971445142748;5726.599138060463;5731.455511726379;5756.94243057564;5817.738201781015;5618.129189975397;5622.5501959842295;5627.662340259598;5635.323761148688;5637.126245431965;5522.2544956431975;5583.944160558342;5617.382087970238;5687.601867869375;5829.242198514166;5573.191887176417;5625.943740562706;5644.85887852807;5645;5655.377908429987;5599.748011339418;5604.579656525695;5617.101263797773;5617.522510586482;5617.691026993554;5217.399999000164;5326.680399176062;5342;5349.893002140013;5478.342598888159;5623.775048997994;5629.915551266652;5633.295838020247;5642;5682.977064128331;5513.173024046425;5519.613627046068;5523.6409633373705;5524.751386187711;5535.723213839211 22:12:55 INFO - PROCESS | 27586 | |1;ext.html;561.2227065514262;604.6009633641797;604.6825416656252;609.945104940555;616.6207782213937;29085.41829163418;29101.272468188305;29558.704412955864;29607.555886661692;37844;41254.58745412545;42021.7898910505;42037;42040;42074.158516829724;8521.659133634663;8685.739427817143;8722.476651400904;8728.650853965866;8732.563371831415;7216.855662886739;7337.743178988737;8474.322054235678;8585.270252028586;10174.898251017468;10056;10132.746681332988;10175.694729158136;10177.287589868713;10180.083792458678;10001.59993600255;10075.143612792921;10076.798464030679;10081.19350451962;10089.949550252202;7653.464257501977;7843.7254696085365;7845.76462706114;10455.424951627658;10721.678349649523;39081.41377879334;39403.211935761414;39419;39452.21095578101;39502.209955800725;3116.2832548513743;3123.2972581169283;3226.080567038383;3295.505674148873;3527.576690797095;29120.271993200127;30027.549586756217;30312.84248281346;30325.24186895323;30416.8479157605;3827.2585973382043;3853.113783829735;3853.2678791029616;3941.1329507508303;3947.4670919426085;265256;266337;266408.6679566609;266550;267175;53724.46275537195;54684.437867455366;55499.44500555024;55780.44219557834;55937.72031139818;60236.39763602308;60309.98450077567;60725.39274607286;60941.69529152326;61080.69459652673;14178.361973711208;14328.49850255236;14383.065100768417;14384.496542620958;14400.351984160738;11067.114630829514;11082.501287442085;11142.331460112257;11143.108551315876;11143.72140696489;18306.450806475827;18475;18488;18495.352662656744;18630.906845465684;7525.4355923305975;7715.652795624211;7748.961255193688;7764.3788496920115;7822.882656760153;896.7489103051156;931.2689538712078;938.9530523473799;960.2462067277154;1067.3169171730099;27726.44547109087;27804.58293125605;27919.58120628192;28130.859345703142;28268.43463130726;1022.2384323678758;1025.8204814157493;1050.821360368739;1059.6715018344185;1147.1052578988401;14500.129992200502;14594.781078283835;14721.190334531704;14875.851241487662;14881.181535015461;320605;326360;326461;326631;327592;50258.96374507572;50282;50312.49687503078;50441.24338134931;50586.747066264434;1195.0738177912187;1242.881926217026;1260.3068312428127;1283.3134273163625;1288.1948782011243;26430.471390571696;27167.45665086727;27398.72601273962;27440;27794.5830812542;41267.7936610327;44730.77634611806;45008.77495612632;45081.549184507734;45124.32313515365;212093;399995;409899;410116;410601;28975.7102428973;29372.18161638973;29456.263593410335;29480.262993425335;29517.409651807273;38990.610093899835;40413.59586404216;40524.79737601411;40755;40823;34086.31827363389;34231.48652770161;34281.657183427844;34615.653843461245;35461.46807797936;34165.7524683351;34658.65341346655;34699.306013879075;34859.82570087133;35090.298194036484;33050.83474582612;33583;33866.153346166546;33922.83038584791;33938.66061339355;29676;31103.377932441676;31184.53223201699;31524.52713209258;31631.36737265288;23587.646185307578;23683.289501314986;23770;23970.40073998094;24286.75713242845 22:12:55 INFO - PROCESS | 27586 | |2;jquery.html;356.4920386763987;358.2423174984907;360.7348598779896;363.74719569898923;364.13154626216465;13544.72910541791;13768.931155344235;16237.675246495062;16507.669846603076;17183.140842957848;10661.786764264729;12373.752524949496;13108;15796.289166987484;15802.920985395085;4756.90486190276;4812.23004319309;4875.512448755132;4876.707397556141;4900.9754951225195;3763.1344790698154;4881.8291359802415;4906.043321552299;4906.950930490703;5002.299678045077;5359.249705041298;5394.109971854659;5427.050266203419;5449.509544141027;5460.672359658413;5065.594752419797;5199.220116982483;5394.514493695567;5406.99999999998;5410.783568657249;5017.222330538772;5018.924716129224;5020.497950204986;5022.84931452057;5024.120778863684;19034.14487826823;20043.498912527157;20100.899495502574;20613.4846628834;21155.576888462143;2018.3586330703445;2109.715188449555;2113.894305284745;2160.546285280093;2190.080166330129;9228;9311.115444032806;9400.811983760286;11164.553417863275;13341.86658133416;1803.1885651456896;1832.7800663920416;1867.6451474219855;1885.70771530413;1893.195391958426;57458.44782103522;60705;62085.37914620886;62613.686931565506;63082;9566.66516671913;9947.602095916081;10050.547725352377;10072.143867771321;10106.747331316628;12797.744045119232;12937.805932911015;12954.935225323814;12961.41673624689;12974.481020759253;7031.929680703128;7307.89038164428;7360.815979600553;7492.950986861843;7559.3196612304055;7153.89269160963;7209.2069872314005;7245.203027666952;7318.268173182639;7415.40676745859;4278.4865816102265;4366.19225443294;4406.691531592758;4446.510883802779;4537.274036154199;1671.8746094042995;1718.2869109319743;1812.4109664358873;1831.5787368905226;1867.4957761404344;379.93541098013407;382.3519135066092;756.4364548411469;932.47315266874;951.9476428796482;9530.142287194047;15439.61400964985;17496.83136894825;17948.37180698669;18369.173387197607;837.8785076163922;861.3410740783306;894.190757364586;899.0559912092277;948.6300342866288;9062.682806101755;9466.337356385126;9537.2370210383;9627.518624068769;9676;511232.7643959236;532452;536130;538576;549318;78894;79785.60107199544;79903;80785.59607201927;82442.17557824466;1116.0792346314324;1118.0384869012642;1128.9830652540218;1130.3895896216115;1135.5571327182406;14983;15067.698646027236;15160.696786063996;15165.317560710015;15337.309821058303;34692.82653586817;34860;34881.1166436694;35051.474227886094;35575.82212088923;46325.30512042255;46682.76658616685;47281.76359118182;47518.28722569234;47722;9176.632934682539;9402.2948278878;9449.669261576088;9455.101765332283;9457.10157535033;10415.1667866572;10438.68683939483;15154.16652084146;16329.183540823149;17317.393891213746;11442.199046067028;11733.647990560297;13456.56560623809;14982.625434364229;15049.77425338599;13257.204567725967;13923.512677056255;14007.299635018413;14152.575422737335;14498.347574358968;14351.425942962582;14418.855811441752;14581.416743330148;14612.19632920157;14630.487932922297;9152.816943661222;9175.403598766326;9353.345265831327;9594.760130996781;9634.71095867125;9851.45816980073;11475.885241147482;14205.928970355082;14754.778678319619;14796.926015369854 22:12:55 INFO - PROCESS | 27586 | |3;mootools.html;1204.0728638948005;1713.742938559216;1743.494386627878;1749.9912500437497;1770.876038677293;6377.776777812777;7195.352418282354;7344.96327518363;7352;7369.410447164228;7427;7596.582187979659;7622.504537205078;7629.580373079479;7637.961810190941;1923.8364738997202;1949.2592814730383;1951.248769223852;2224.833137514685;2268.421552504109;2235.228846048111;2260.107257633234;2268.1494439585153;2276.46503071778;2276.8633881967135;2160.157538559963;2196.6924630551734;2227.7103976483036;2228.22012295696;2230.241717815942;2179.1719146724304;2243.3270018994317;2274.8293877959136;2276.5560715660454;2279.8290128240365;2245.7529671736097;2253.3577930289953;2290.5647926893835;2291.747907730148;2294.8393612447135;7476.14024387197;7488.251174882523;7488.363489103433;7500.962495187489;7590.962045189794;4545.613622842063;4648.442186937556;4682.6019788318035;4710.69380490267;4712.95287047132;3002.24943764059;3090.443720130398;3121.78147529673;3153.3220357623222;3156.163616641592;943.1181844974902;948.7722946492861;974.9853752193723;1014.6854475112739;1023.4013102335143;10262.281640285182;10320.79358412835;10343.120834729058;10391.688249352532;10420.531076101593;3948.1511475033008;4033.858814941463;4061.939070913939;4067.877963661095;4096.569860164699;8118.391120665856;8142.063662678749;8151.5109093454585;8154.306883914815;8159.184081591793;4517.977410112994;4527.61515271199;4547.181507328646;4569.246074397754;4571.3600095986585;4190.811413486401;4224.957750422518;4233.238017156941;4238.554951730024;4243.236217480821;3137.13728724598;3168.603924509436;3220.2271454850666;3391.9660803392144;3506.4564992426212;1093.1965005720788;1095.5343978808974;1099.2580008494235;1102.5369344875012;1111.4165063341811;891.2112780189449;973.9902600974041;974.1281553010016;1038.5222797513077;1283.9743205135844;7126.5011449198055;7169.24722904098;7171.964140179266;7174.210836807947;7179.174394944544;585.8183962971492;589.9911501327483;604.7913469852894;604.803438882365;729.8650598319664;5628.380878103405;5628.409017053233;5668.7165641718575;5673.886522269531;5710.600257981901;8932.732018039469;8975.192232699088;9020.819583608421;9149.130832570896;9160.175584197454;8990.100989901088;9056.818863622691;9077.228435582918;9084.682036128705;9101.772455688528;7073.787786366417;7108.68010939509;7183.317584829538;7183.604901730455;7183.92816071843;6823.1812182538415;6867.381935625618;6886.965565172142;6897.379235868796;6904.3095690432565;7961.402894782798;8047.758567242992;8104.716334928485;8239;8256.380771442286;8196.057453392936;8357.623906924082;8476.321894248322;8484.278836298983;8490.363222758442;6413.16628838248;6417.294097649162;6420.454261387647;6451.032345148265;6523.67381630907;6430.164078669743;6629.303923088007;6805.3875151236625;7409.518381305198;7439.479236453396;6679.06493090958;6714.227863795726;6828.419584335387;6868.416184624363;6938.098047253825;6621.966890165519;6655.567388119756;6682.031105489774;6744.662766861736;6753.459723222229;6784.287649796897;6787.592744435349;6790.083338749206;6793.2867048961125;6810.931890681228;6258.62448253088;6288.245410550763;6297.905531417124;6310.7475700971445;6316.905246421399;6115.449609535163;6338.524610654312;6359.8092057238355;6368.267649220399;6373.203349581302 22:12:55 INFO - PROCESS | 27586 | |4;prototype.html;329.8779451602907;331.64679616208736;336.2820378491919;340.6661471757677;344.8206932395153;5846.6199697019665;5881.323647780507;5923.200367950325;5937.22816033916;5982.102684597313;5586.441355864422;5656.802011929583;5765.365809760923;5854.912176317348;5892.204552385427;4505.301678239862;4505.504394516601;4508.481524624661;4511;4514.187446259672;4246.7027308088445;4515.803312122291;4525.47956984946;4527.52460991596;4540.228161212602;4304.246756817544;4407.889802754925;4493.191225579394;4500.122476117159;4524.411826462555;4471.262241730111;4496.482904465979;4498.100379923995;4507.977460112695;4514.864554063383;3971.6028397160344;3977.8011099445202;3983.103801644636;3984.2629113614075;3987.521497420328;5514.172874068881;5590.329160500766;5592.972035139798;5600.355959064719;5600.747966341483;5253.605979551511;5262.868428289324;5263.157894736862;5263.842084737464;5264.341957255343;6204.379562043805;6212.72042758077;6213.347598502182;6223.3776622337855;6225.159603453566;4400.603945644907;4401.603855653007;4409.470863496369;4411.029573493826;4421.850318917072;6312.747490100436;6472.352764723537;6474.125992990933;6476.352364763533;6485.5460117792245;4506.932396014063;4507.459104907432;4508.346289787963;4517.570830771071;4519.344695019204;4496.820127194941;4555.339475775994;4560.521145279764;4564.543545645475;4564.817407303737;5232.162853943427;5232.764525596357;5233.71214583194;5236.9738151309;5242.868928276824;6162.22972128484;6260.5617606768;6266.122742816009;6279.748810047547;6282.2147231596055;1590.90454572726;1599.896006759557;1600.1439230011888;1608.035178892655;1609.050660110517;1105.1048650593045;1111.0389513071136;1113.8607674040745;1124.7413094988199;1133.8582677165355;6045.1234570987845;6046.969765151146;6052.182955301066;6052.788152414644;6064.818055458343;6484.027395890655;6490.2536208335705;6501.512386571026;6508.446782023487;6515.902261466082;5865.941340586625;5956.404359564096;6015.819525414245;6119.632822030692;6124.203853499017;3517.2613751112553;3539.0975301298004;3540.274243780019;3551.804650744234;3551.9289614207573;6646.800595982031;6654.201495820533;6659.6670166491485;6666.699998500079;6686.866262674719;6556.213254409501;6667.299933507009;6672.9332706673285;6675.332466753286;6686.498512611476;6660.666966651648;6666.466682665375;6666.533342665967;6677.53257271996;6683.866322673519;6528.6735663215695;6549.115869357575;6550.213974323112;6556.082148499118;6560.639164845979;6320.209973753281;6483.448906842971;6484.70818813164;6490.831650302802;6495.350464953467;6656.83357916056;6660.966695166493;6668.199816022108;6679.465642748665;6687.565308254948;4474.485434175112;4476.776161191992;4478;4479.372887795646;4486.10277944419;6409.551331406757;6550.377714117342;6555.410013098844;6557.672116394066;6562.34376562359;6368.299487056327;6370.936290637034;6375.904361434489;6382.776602818879;6394.84892719315;6347.174867267226;6358.682065896594;6361.395667411589;6366.076918846648;6367.936320636734;6015.368386319374;6141.048137538689;6181.320054794059;6199.814005579839;6214.4407003369915;6381.329960354096;6391.105245265573;6393.6163830170335;6402.10370548133;6403.0715546246465;6215.160953271251;6230.50155987529;6234.6570938597;6238.438540531374;6239.282482514569 22:12:55 INFO - PROCESS | 27586 | |5;yui.html;750.5571712689513;816.8849520404646;817.2738363270289;818.4925346285304;856.1695155698969;12998.285094319821;13313.866861331384;13318.334083295846;13327.533536326231;13400.262985535792;12727;12732.172408793422;12738.426770795313;12890.097693161459;12914.418851151697;673.6699017481424;680.068306420205;810.2909953790448;817.8568750468673;817.9386546009043;819.7991492084448;821.9301359384459;827.4332082523491;827.93790465715;828.329053466694;857.5069335132292;869.2046777198887;869.5912920927186;870.8954925408959;873.1225118755674;714.0324859814954;714.7391202211181;847.3560094328293;864.9351298652626;866.3372520022189;630.2846269484123;632.1939527102935;634.9713464188045;635.0030452190064;635.3931994944817;12957.935210323889;13026.80459793104;13045.152065115737;13104.86895131046;13286.86713132866;11543.422828858607;11554.306741595447;11917.642470725892;12157.392130393446;12383.442745076492;10393.545397008967;10492.632757853438;10608.257421980465;10774.730631734192;10827.512761925733;3512.543369361992;3578.8210589470423;3621.0947263184203;3626.34725749365;3682.815859207029;44232.778836105936;44372;44383;44394.33408498875;44606.776966115285;9582.472963987047;9646.469444180497;9650.324477286522;9658.130768230892;9788.902110978941;17447.65104697899;17466;17557.82442175562;17561.824381756276;17569.209385577426;7458.552486850698;7502.062242219723;7596.81007974794;7729.806754831175;7932.881006784903;4252.255855225323;4300.80646370914;4344.869653910388;4415.116976604692;4425.468943726709;3258.885938992124;3274.5743053402907;3283.4089863824265;3294.950575741366;3298.340331933623;679.6363945289345;682.4438082962469;684.7089986755609;694.9409300209438;701.0465766557478;567.4807551090788;647.873664635401;673.8854394752904;690.2579726793717;702.9789106326818;8923.40733711263;8952.910470895338;9093.181613654802;9128.22410095136;9155.404898681565;545.7298637174624;549.5164255455173;550.9228707980886;599.8320470268332;656.6191608866845;3628.6552777486095;3722.6277372262557;3765;3788.7726736395903;3999.9002767320917;58883.41116588865;60204;60276.09585856128;60416.093758593655;60443.69778151169;52532.737336313076;52848.735756321745;53129;53466.73266633642;54245;46446;46618.76690616525;47367.52632473631;47497.28754068692;48630.75684621554;8549.358798090292;8606.483610983361;8744.519051452231;8812.86780698303;8867.379283450096;34351.65648343485;34575.13562160966;34817.65182348144;35363;35416.64583354133;41469.58530414778;41531.792341038104;42437.78781106075;45037.32444013277;45693.54306456893;10745.838812417664;11058.22592418523;11149.72125696864;11304.83042754343;11649.41752912334;12136.878631213927;12178;12416.565420210249;12707.80938285945;12806.423710932844;11688.88311116878;11716.355600442057;11730.70673233176;11963.700907477383;12190.817137742764;11303.660890173307;11410.543578256777;11566.94216528912;11891.82162267584;11902.285862848257;11807.350595717318;12160.635180944586;12179.39103044862;12241.938790305992;12606.306653134166;10102.667362716407;10211.846822297523;10299.639512617023;10622;10867.619633313112;9347.766305842408;9520.868304783502;9624.566894489624;10077.9169052302;10217 22:12:55 INFO - PROCESS | 27586 | __end_tp_report 22:12:55 INFO - PROCESS | 27586 | __start_cc_report 22:12:55 INFO - PROCESS | 27586 | _x_x_mozilla_cycle_collect,887 22:12:55 INFO - PROCESS | 27586 | __end_cc_report 22:12:55 INFO - PROCESS | 27586 | __startTimestamp1450764775829__endTimestamp 22:12:55 INFO - PROCESS | 27586 | 22:12:55 INFO - PROCESS | 27586 | ------- Summary: start ------- 22:12:55 INFO - PROCESS | 27586 | Number of tests: 6 22:12:55 INFO - PROCESS | 27586 | 22:12:55 INFO - PROCESS | 27586 | [#0] dojo.html Cycles:165 Average:5266.13 Median:5513.17 stddev:576.56 (10.5%) stddev-sans-first:552.64 22:12:55 INFO - PROCESS | 27586 | Values: 3096.8 3131.5 3201.7 3203.0 3227.7 5096.5 5227.4 5289.5 5349.3 5387.7 5251.4 5267.5 5310.3 5323.5 5378.6 4770.3 4788.3 4790.5 4809.4 4896.5 4838.7 4911.2 4915.5 4943.3 5000.3 4721.2 4743.1 4842.4 4847.8 4908.7 4828.3 4843.8 4852.0 4854.0 4866.3 4794.6 4803.6 4811.7 4819.1 4866.4 5029.7 5133.4 5142.9 5146.9 5151.0 5658.8 5721.6 5731.7 5779.1 5785.9 5768.9 5781.9 5805.8 5808.4 5809.2 5113.7 5216.7 5408.9 5427.2 5430.0 5697.2 5705.5 5721.4 5727.3 5765.9 5554.9 5556.6 5559.2 5609.4 5610.7 5516.8 5597.2 5620.0 5651.8 5711.7 5555.9 5585.7 5611.6 5627.9 5629.5 5619.7 5620.3 5620.9 5621.0 5624.7 4212.7 4311.4 4373.3 4374.1 4418.9 3831.4 3872.7 3873.7 3910.7 3916.2 5325.1 5328.2 5329.8 5330.5 5375.9 5482.1 5599.5 5601.2 5691.3 5709.9 5328.5 5440.7 5447.9 5458.2 5461.9 4966.2 4976.3 4999.1 5002.3 5032.6 5685.7 5746.4 5755.6 5756.4 5764.7 5450.7 5555.2 5576.6 5604.6 5780.6 5711.0 5726.6 5731.5 5756.9 5817.7 5618.1 5622.6 5627.7 5635.3 5637.1 5522.3 5583.9 5617.4 5687.6 5829.2 5573.2 5625.9 5644.9 5645.0 5655.4 5599.7 5604.6 5617.1 5617.5 5617.7 5217.4 5326.7 5342.0 5349.9 5478.3 5623.8 5629.9 5633.3 5642.0 5683.0 5513.2 5519.6 5523.6 5524.8 5535.7 22:12:55 INFO - PROCESS | 27586 | 22:12:55 INFO - PROCESS | 27586 | [#1] ext.html Cycles:180 Average:47759.58 Median:327111.50 stddev:85815.11 (26.2%) stddev-sans-first:85982.67 22:12:55 INFO - PROCESS | 27586 | Values: 561.2 604.6 604.7 609.9 616.6 29085.4 29101.3 29558.7 29607.6 37844.0 41254.6 42021.8 42037.0 42040.0 42074.2 8521.7 8685.7 8722.5 8728.7 8732.6 7216.9 7337.7 8474.3 8585.3 10174.9 10056.0 10132.7 10175.7 10177.3 10180.1 10001.6 10075.1 10076.8 10081.2 10089.9 7653.5 7843.7 7845.8 10455.4 10721.7 39081.4 39403.2 39419.0 39452.2 39502.2 3116.3 3123.3 3226.1 3295.5 3527.6 29120.3 30027.5 30312.8 30325.2 30416.8 3827.3 3853.1 3853.3 3941.1 3947.5 265256.0 266337.0 266408.7 266550.0 267175.0 53724.5 54684.4 55499.4 55780.4 55937.7 60236.4 60310.0 60725.4 60941.7 61080.7 14178.4 14328.5 14383.1 14384.5 14400.4 11067.1 11082.5 11142.3 11143.1 11143.7 18306.5 18475.0 18488.0 18495.4 18630.9 7525.4 7715.7 7749.0 7764.4 7822.9 896.7 931.3 939.0 960.2 1067.3 27726.4 27804.6 27919.6 28130.9 28268.4 1022.2 1025.8 1050.8 1059.7 1147.1 14500.1 14594.8 14721.2 14875.9 14881.2 320605.0 326360.0 326461.0 326631.0 327592.0 50259.0 50282.0 50312.5 50441.2 50586.7 1195.1 1242.9 1260.3 1283.3 1288.2 26430.5 27167.5 27398.7 27440.0 27794.6 41267.8 44730.8 45008.8 45081.5 45124.3 212093.0 399995.0 409899.0 410116.0 410601.0 28975.7 29372.2 29456.3 29480.3 29517.4 38990.6 40413.6 40524.8 40755.0 40823.0 34086.3 34231.5 34281.7 34615.7 35461.5 34165.8 34658.7 34699.3 34859.8 35090.3 33050.8 33583.0 33866.2 33922.8 33938.7 29676.0 31103.4 31184.5 31524.5 31631.4 23587.6 23683.3 23770.0 23970.4 24286.8 22:12:55 INFO - PROCESS | 27586 | 22:12:55 INFO - PROCESS | 27586 | [#2] jquery.html Cycles:180 Average:28354.99 Median:2330.42 stddev:87282.35 (3745.3%) stddev-sans-first:87501.88 22:12:55 INFO - PROCESS | 27586 | Values: 356.5 358.2 360.7 363.7 364.1 13544.7 13768.9 16237.7 16507.7 17183.1 10661.8 12373.8 13108.0 15796.3 15802.9 4756.9 4812.2 4875.5 4876.7 4901.0 3763.1 4881.8 4906.0 4907.0 5002.3 5359.2 5394.1 5427.1 5449.5 5460.7 5065.6 5199.2 5394.5 5407.0 5410.8 5017.2 5018.9 5020.5 5022.8 5024.1 19034.1 20043.5 20100.9 20613.5 21155.6 2018.4 2109.7 2113.9 2160.5 2190.1 9228.0 9311.1 9400.8 11164.6 13341.9 1803.2 1832.8 1867.6 1885.7 1893.2 57458.4 60705.0 62085.4 62613.7 63082.0 9566.7 9947.6 10050.5 10072.1 10106.7 12797.7 12937.8 12954.9 12961.4 12974.5 7031.9 7307.9 7360.8 7493.0 7559.3 7153.9 7209.2 7245.2 7318.3 7415.4 4278.5 4366.2 4406.7 4446.5 4537.3 1671.9 1718.3 1812.4 1831.6 1867.5 379.9 382.4 756.4 932.5 951.9 9530.1 15439.6 17496.8 17948.4 18369.2 837.9 861.3 894.2 899.1 948.6 9062.7 9466.3 9537.2 9627.5 9676.0 511232.8 532452.0 536130.0 538576.0 549318.0 78894.0 79785.6 79903.0 80785.6 82442.2 1116.1 1118.0 1129.0 1130.4 1135.6 14983.0 15067.7 15160.7 15165.3 15337.3 34692.8 34860.0 34881.1 35051.5 35575.8 46325.3 46682.8 47281.8 47518.3 47722.0 9176.6 9402.3 9449.7 9455.1 9457.1 10415.2 10438.7 15154.2 16329.2 17317.4 11442.2 11733.6 13456.6 14982.6 15049.8 13257.2 13923.5 14007.3 14152.6 14498.3 14351.4 14418.9 14581.4 14612.2 14630.5 9152.8 9175.4 9353.3 9594.8 9634.7 9851.5 11475.9 14205.9 14754.8 14796.9 22:12:55 INFO - PROCESS | 27586 | 22:12:55 INFO - PROCESS | 27586 | [#3] mootools.html Cycles:180 Average:5243.79 Median:6364.04 stddev:2721.87 (42.8%) stddev-sans-first:2712.57 22:12:55 INFO - PROCESS | 27586 | Values: 1204.1 1713.7 1743.5 1750.0 1770.9 6377.8 7195.4 7345.0 7352.0 7369.4 7427.0 7596.6 7622.5 7629.6 7638.0 1923.8 1949.3 1951.2 2224.8 2268.4 2235.2 2260.1 2268.1 2276.5 2276.9 2160.2 2196.7 2227.7 2228.2 2230.2 2179.2 2243.3 2274.8 2276.6 2279.8 2245.8 2253.4 2290.6 2291.7 2294.8 7476.1 7488.3 7488.4 7501.0 7591.0 4545.6 4648.4 4682.6 4710.7 4713.0 3002.2 3090.4 3121.8 3153.3 3156.2 943.1 948.8 975.0 1014.7 1023.4 10262.3 10320.8 10343.1 10391.7 10420.5 3948.2 4033.9 4061.9 4067.9 4096.6 8118.4 8142.1 8151.5 8154.3 8159.2 4518.0 4527.6 4547.2 4569.2 4571.4 4190.8 4225.0 4233.2 4238.6 4243.2 3137.1 3168.6 3220.2 3392.0 3506.5 1093.2 1095.5 1099.3 1102.5 1111.4 891.2 974.0 974.1 1038.5 1284.0 7126.5 7169.2 7172.0 7174.2 7179.2 585.8 590.0 604.8 604.8 729.9 5628.4 5628.4 5668.7 5673.9 5710.6 8932.7 8975.2 9020.8 9149.1 9160.2 8990.1 9056.8 9077.2 9084.7 9101.8 7073.8 7108.7 7183.3 7183.6 7183.9 6823.2 6867.4 6887.0 6897.4 6904.3 7961.4 8047.8 8104.7 8239.0 8256.4 8196.1 8357.6 8476.3 8484.3 8490.4 6413.2 6417.3 6420.5 6451.0 6523.7 6430.2 6629.3 6805.4 7409.5 7439.5 6679.1 6714.2 6828.4 6868.4 6938.1 6622.0 6655.6 6682.0 6744.7 6753.5 6784.3 6787.6 6790.1 6793.3 6810.9 6258.6 6288.2 6297.9 6310.7 6316.9 6115.4 6338.5 6359.8 6368.3 6373.2 22:12:55 INFO - PROCESS | 27586 | 22:12:55 INFO - PROCESS | 27586 | [#4] prototype.html Cycles:180 Average:5260.34 Median:5969.25 stddev:1578.02 (26.4%) stddev-sans-first:1538.44 22:12:55 INFO - PROCESS | 27586 | Values: 329.9 331.6 336.3 340.7 344.8 5846.6 5881.3 5923.2 5937.2 5982.1 5586.4 5656.8 5765.4 5854.9 5892.2 4505.3 4505.5 4508.5 4511.0 4514.2 4246.7 4515.8 4525.5 4527.5 4540.2 4304.2 4407.9 4493.2 4500.1 4524.4 4471.3 4496.5 4498.1 4508.0 4514.9 3971.6 3977.8 3983.1 3984.3 3987.5 5514.2 5590.3 5593.0 5600.4 5600.7 5253.6 5262.9 5263.2 5263.8 5264.3 6204.4 6212.7 6213.3 6223.4 6225.2 4400.6 4401.6 4409.5 4411.0 4421.9 6312.7 6472.4 6474.1 6476.4 6485.5 4506.9 4507.5 4508.3 4517.6 4519.3 4496.8 4555.3 4560.5 4564.5 4564.8 5232.2 5232.8 5233.7 5237.0 5242.9 6162.2 6260.6 6266.1 6279.7 6282.2 1590.9 1599.9 1600.1 1608.0 1609.1 1105.1 1111.0 1113.9 1124.7 1133.9 6045.1 6047.0 6052.2 6052.8 6064.8 6484.0 6490.3 6501.5 6508.4 6515.9 5865.9 5956.4 6015.8 6119.6 6124.2 3517.3 3539.1 3540.3 3551.8 3551.9 6646.8 6654.2 6659.7 6666.7 6686.9 6556.2 6667.3 6672.9 6675.3 6686.5 6660.7 6666.5 6666.5 6677.5 6683.9 6528.7 6549.1 6550.2 6556.1 6560.6 6320.2 6483.4 6484.7 6490.8 6495.4 6656.8 6661.0 6668.2 6679.5 6687.6 4474.5 4476.8 4478.0 4479.4 4486.1 6409.6 6550.4 6555.4 6557.7 6562.3 6368.3 6370.9 6375.9 6382.8 6394.8 6347.2 6358.7 6361.4 6366.1 6367.9 6015.4 6141.0 6181.3 6199.8 6214.4 6381.3 6391.1 6393.6 6402.1 6403.1 6215.2 6230.5 6234.7 6238.4 6239.3 22:12:55 INFO - PROCESS | 27586 | 22:12:55 INFO - PROCESS | 27586 | [#5] yui.html Cycles:180 Average:13848.43 Median:24398.73 stddev:16023.27 (65.7%) stddev-sans-first:16038.03 22:12:55 INFO - PROCESS | 27586 | Values: 750.6 816.9 817.3 818.5 856.2 12998.3 13313.9 13318.3 13327.5 13400.3 12727.0 12732.2 12738.4 12890.1 12914.4 673.7 680.1 810.3 817.9 817.9 819.8 821.9 827.4 827.9 828.3 857.5 869.2 869.6 870.9 873.1 714.0 714.7 847.4 864.9 866.3 630.3 632.2 635.0 635.0 635.4 12957.9 13026.8 13045.2 13104.9 13286.9 11543.4 11554.3 11917.6 12157.4 12383.4 10393.5 10492.6 10608.3 10774.7 10827.5 3512.5 3578.8 3621.1 3626.3 3682.8 44232.8 44372.0 44383.0 44394.3 44606.8 9582.5 9646.5 9650.3 9658.1 9788.9 17447.7 17466.0 17557.8 17561.8 17569.2 7458.6 7502.1 7596.8 7729.8 7932.9 4252.3 4300.8 4344.9 4415.1 4425.5 3258.9 3274.6 3283.4 3295.0 3298.3 679.6 682.4 684.7 694.9 701.0 567.5 647.9 673.9 690.3 703.0 8923.4 8952.9 9093.2 9128.2 9155.4 545.7 549.5 550.9 599.8 656.6 3628.7 3722.6 3765.0 3788.8 3999.9 58883.4 60204.0 60276.1 60416.1 60443.7 52532.7 52848.7 53129.0 53466.7 54245.0 46446.0 46618.8 47367.5 47497.3 48630.8 8549.4 8606.5 8744.5 8812.9 8867.4 34351.7 34575.1 34817.7 35363.0 35416.6 41469.6 41531.8 42437.8 45037.3 45693.5 10745.8 11058.2 11149.7 11304.8 11649.4 12136.9 12178.0 12416.6 12707.8 12806.4 11688.9 11716.4 11730.7 11963.7 12190.8 11303.7 11410.5 11566.9 11891.8 11902.3 11807.4 12160.6 12179.4 12241.9 12606.3 10102.7 10211.8 10299.6 10622.0 10867.6 9347.8 9520.9 9624.6 10077.9 10217.0 22:12:55 INFO - PROCESS | 27586 | -------- Summary: end -------- 22:12:55 INFO - PROCESS | 27586 | 22:12:56 INFO - TEST-INFO | 27586: exit 0 22:12:56 INFO - TEST-OK | dromaeo_css | took 1112987ms 22:12:56 INFO - TEST-START | kraken 22:12:56 INFO - operating with platform_type : linux_ 22:12:56 INFO - Initialising browser for kraken test... 22:12:56 INFO - TEST-INFO | started process 27769 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2BKFhg/profile http://localhost:41729/getInfo.html) 22:13:00 INFO - PROCESS | 27769 | __metrics Screen width/height:1600/1200 22:13:00 INFO - PROCESS | 27769 | colorDepth:24 22:13:00 INFO - PROCESS | 27769 | Browser inner width/height: 1024/697 22:13:00 INFO - PROCESS | 27769 | __metrics 22:13:00 INFO - PROCESS | 27769 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:13:00 INFO - PROCESS | 27769 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:13:00 ERROR - PROCESS | 27769 | JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 22:13:01 INFO - TEST-INFO | 27769: exit 0 22:13:01 INFO - Browser initialized. 22:13:01 INFO - Running cycle 1/1 for kraken test... 22:13:01 INFO - TEST-INFO | started process 27851 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2BKFhg/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:13:13 INFO - PROCESS | 27851 | RSS: Main: 149540864 22:13:13 INFO - PROCESS | 27851 | 22:13:15 INFO - PROCESS | 27851 | Cycle 1(1): loaded http://localhost:41729/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41729/tests/kraken/driver.html?testName=audio-beat-detection) 22:13:16 INFO - PROCESS | 27851 | RSS: Main: 186204160 22:13:16 INFO - PROCESS | 27851 | 22:13:19 INFO - PROCESS | 27851 | Cycle 1(1): loaded http://localhost:41729/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41729/tests/kraken/driver.html?testName=audio-dft) 22:13:19 INFO - PROCESS | 27851 | RSS: Main: 176095232 22:13:19 INFO - PROCESS | 27851 | 22:13:22 INFO - PROCESS | 27851 | Cycle 1(1): loaded http://localhost:41729/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41729/tests/kraken/driver.html?testName=audio-fft) 22:13:23 INFO - PROCESS | 27851 | RSS: Main: 160256000 22:13:23 INFO - PROCESS | 27851 | 22:13:25 INFO - PROCESS | 27851 | Cycle 1(1): loaded http://localhost:41729/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41729/tests/kraken/driver.html?testName=audio-oscillator) 22:13:25 INFO - PROCESS | 27851 | RSS: Main: 162492416 22:13:25 INFO - PROCESS | 27851 | 22:13:27 INFO - PROCESS | 27851 | Cycle 1(1): loaded http://localhost:41729/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41729/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:13:28 INFO - PROCESS | 27851 | RSS: Main: 164446208 22:13:28 INFO - PROCESS | 27851 | 22:13:31 INFO - PROCESS | 27851 | Cycle 1(1): loaded http://localhost:41729/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41729/tests/kraken/driver.html?testName=imaging-darkroom) 22:13:31 INFO - PROCESS | 27851 | RSS: Main: 165969920 22:13:31 INFO - PROCESS | 27851 | 22:13:35 INFO - PROCESS | 27851 | Cycle 1(1): loaded http://localhost:41729/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41729/tests/kraken/driver.html?testName=imaging-desaturate) 22:13:35 INFO - PROCESS | 27851 | RSS: Main: 166563840 22:13:35 INFO - PROCESS | 27851 | 22:13:38 INFO - PROCESS | 27851 | Cycle 1(1): loaded http://localhost:41729/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41729/tests/kraken/driver.html?testName=json-parse-financial) 22:13:39 INFO - PROCESS | 27851 | RSS: Main: 164909056 22:13:39 INFO - PROCESS | 27851 | 22:13:40 INFO - PROCESS | 27851 | Cycle 1(1): loaded http://localhost:41729/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41729/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:13:41 INFO - PROCESS | 27851 | RSS: Main: 177668096 22:13:41 INFO - PROCESS | 27851 | 22:13:43 INFO - PROCESS | 27851 | Cycle 1(1): loaded http://localhost:41729/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41729/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:13:43 INFO - PROCESS | 27851 | RSS: Main: 175931392 22:13:43 INFO - PROCESS | 27851 | 22:13:45 INFO - PROCESS | 27851 | Cycle 1(1): loaded http://localhost:41729/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41729/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:13:46 INFO - PROCESS | 27851 | RSS: Main: 183533568 22:13:46 INFO - PROCESS | 27851 | 22:13:48 INFO - PROCESS | 27851 | Cycle 1(1): loaded http://localhost:41729/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:13:49 INFO - PROCESS | 27851 | RSS: Main: 193761280 22:13:49 INFO - PROCESS | 27851 | 22:13:51 INFO - PROCESS | 27851 | Cycle 1(1): loaded http://localhost:41729/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:13:52 INFO - PROCESS | 27851 | RSS: Main: 189841408 22:13:52 INFO - PROCESS | 27851 | 22:13:54 INFO - PROCESS | 27851 | Cycle 1(1): loaded http://localhost:41729/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41729/tests/kraken/driver.html?testName=ai-astar) 22:13:54 INFO - PROCESS | 27851 | RSS: Main: 249020416 22:13:54 INFO - PROCESS | 27851 | 22:13:54 INFO - PROCESS | 27851 | __start_tp_report 22:13:54 INFO - PROCESS | 27851 | _x_x_mozilla_page_load 22:13:54 INFO - PROCESS | 27851 | _x_x_mozilla_page_load_details 22:13:54 INFO - PROCESS | 27851 | |i|pagename|runs| 22:13:54 INFO - PROCESS | 27851 | |0;ai-astar;110;111;105;111;112;112;101;110;111;115 22:13:54 INFO - PROCESS | 27851 | |1;audio-beat-detection;151;124;148;162;125;150;157;125;163;126 22:13:54 INFO - PROCESS | 27851 | |2;audio-dft;161;161;161;163;161;163;160;164;161;163 22:13:54 INFO - PROCESS | 27851 | |3;audio-fft;73;73;90;96;74;71;73;99;95;73 22:13:54 INFO - PROCESS | 27851 | |4;audio-oscillator;94;95;138;93;94;94;139;95;94;138 22:13:54 INFO - PROCESS | 27851 | |5;imaging-gaussian-blur;110;110;110;109;109;109;110;109;110;110 22:13:54 INFO - PROCESS | 27851 | |6;imaging-darkroom;146;146;146;145;147;148;146;146;146;146 22:13:54 INFO - PROCESS | 27851 | |7;imaging-desaturate;96;97;97;96;95;95;96;96;96;95 22:13:54 INFO - PROCESS | 27851 | |8;json-parse-financial;59;57;57;56;56;57;58;67;54;56 22:13:54 INFO - PROCESS | 27851 | |9;json-stringify-tinderbox;68;67;68;67;69;68;68;67;67;68 22:13:54 INFO - PROCESS | 27851 | |10;stanford-crypto-aes;85;85;85;86;85;86;87;93;86;85 22:13:54 INFO - PROCESS | 27851 | |11;stanford-crypto-ccm;129;124;116;124;121;127;119;126;125;122 22:13:54 INFO - PROCESS | 27851 | |12;stanford-crypto-pbkdf2;143;140;151;163;153;145;156;149;151;153 22:13:54 INFO - PROCESS | 27851 | |13;stanford-crypto-sha256-iterative;67;67;67;67;67;66;67;66;69;68 22:13:54 INFO - PROCESS | 27851 | __end_tp_report 22:13:54 INFO - PROCESS | 27851 | __start_cc_report 22:13:54 INFO - PROCESS | 27851 | _x_x_mozilla_cycle_collect,945 22:13:54 INFO - PROCESS | 27851 | __end_cc_report 22:13:54 INFO - PROCESS | 27851 | __startTimestamp1450764834507__endTimestamp 22:13:54 INFO - PROCESS | 27851 | 22:13:54 INFO - PROCESS | 27851 | ------- Summary: start ------- 22:13:54 INFO - PROCESS | 27851 | Number of tests: 14 22:13:54 INFO - PROCESS | 27851 | 22:13:54 INFO - PROCESS | 27851 | [#0] ai-astar Cycles:10 Average:109.80 Median:111.00 stddev:3.97 (3.6%) stddev-sans-first:4.21 22:13:54 INFO - PROCESS | 27851 | Values: 110.0 111.0 105.0 111.0 112.0 112.0 101.0 110.0 111.0 115.0 22:13:54 INFO - PROCESS | 27851 | 22:13:54 INFO - PROCESS | 27851 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:150.50 stddev:16.31 (10.8%) stddev-sans-first:17.04 22:13:54 INFO - PROCESS | 27851 | Values: 151.0 124.0 148.0 162.0 125.0 150.0 157.0 125.0 163.0 126.0 22:13:54 INFO - PROCESS | 27851 | 22:13:54 INFO - PROCESS | 27851 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.32 (0.8%) stddev-sans-first:1.36 22:13:54 INFO - PROCESS | 27851 | Values: 161.0 161.0 161.0 163.0 161.0 163.0 160.0 164.0 161.0 163.0 22:13:54 INFO - PROCESS | 27851 | 22:13:54 INFO - PROCESS | 27851 | [#3] audio-fft Cycles:10 Average:81.70 Median:82.00 stddev:11.67 (14.2%) stddev-sans-first:11.95 22:13:54 INFO - PROCESS | 27851 | Values: 73.0 73.0 90.0 96.0 74.0 71.0 73.0 99.0 95.0 73.0 22:13:54 INFO - PROCESS | 27851 | 22:13:54 INFO - PROCESS | 27851 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:94.00 stddev:21.36 (22.7%) stddev-sans-first:22.09 22:13:54 INFO - PROCESS | 27851 | Values: 94.0 95.0 138.0 93.0 94.0 94.0 139.0 95.0 94.0 138.0 22:13:54 INFO - PROCESS | 27851 | 22:13:54 INFO - PROCESS | 27851 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:13:54 INFO - PROCESS | 27851 | Values: 110.0 110.0 110.0 109.0 109.0 109.0 110.0 109.0 110.0 110.0 22:13:54 INFO - PROCESS | 27851 | 22:13:54 INFO - PROCESS | 27851 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 22:13:54 INFO - PROCESS | 27851 | Values: 146.0 146.0 146.0 145.0 147.0 148.0 146.0 146.0 146.0 146.0 22:13:54 INFO - PROCESS | 27851 | 22:13:54 INFO - PROCESS | 27851 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 22:13:54 INFO - PROCESS | 27851 | Values: 96.0 97.0 97.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 22:13:54 INFO - PROCESS | 27851 | 22:13:54 INFO - PROCESS | 27851 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.00 stddev:3.53 (6.2%) stddev-sans-first:3.71 22:13:54 INFO - PROCESS | 27851 | Values: 59.0 57.0 57.0 56.0 56.0 57.0 58.0 67.0 54.0 56.0 22:13:54 INFO - PROCESS | 27851 | 22:13:54 INFO - PROCESS | 27851 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 22:13:54 INFO - PROCESS | 27851 | Values: 68.0 67.0 68.0 67.0 69.0 68.0 68.0 67.0 67.0 68.0 22:13:54 INFO - PROCESS | 27851 | 22:13:54 INFO - PROCESS | 27851 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.00 stddev:2.45 (2.9%) stddev-sans-first:2.55 22:13:54 INFO - PROCESS | 27851 | Values: 85.0 85.0 85.0 86.0 85.0 86.0 87.0 93.0 86.0 85.0 22:13:54 INFO - PROCESS | 27851 | 22:13:54 INFO - PROCESS | 27851 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:124.50 stddev:3.89 (3.1%) stddev-sans-first:3.54 22:13:54 INFO - PROCESS | 27851 | Values: 129.0 124.0 116.0 124.0 121.0 127.0 119.0 126.0 125.0 122.0 22:13:54 INFO - PROCESS | 27851 | 22:13:54 INFO - PROCESS | 27851 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.40 Median:152.00 stddev:6.65 (4.4%) stddev-sans-first:6.50 22:13:54 INFO - PROCESS | 27851 | Values: 143.0 140.0 151.0 163.0 153.0 145.0 156.0 149.0 151.0 153.0 22:13:54 INFO - PROCESS | 27851 | 22:13:54 INFO - PROCESS | 27851 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 22:13:54 INFO - PROCESS | 27851 | Values: 67.0 67.0 67.0 67.0 67.0 66.0 67.0 66.0 69.0 68.0 22:13:54 INFO - PROCESS | 27851 | -------- Summary: end -------- 22:13:54 INFO - PROCESS | 27851 | 22:13:55 INFO - TEST-INFO | 27851: exit 0 22:13:55 INFO - TEST-OK | kraken | took 58821ms 22:13:55 INFO - TEST-START | v8_7 22:13:55 INFO - operating with platform_type : linux_ 22:13:55 INFO - Initialising browser for v8_7 test... 22:13:55 INFO - TEST-INFO | started process 28100 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7JadFv/profile http://localhost:41729/getInfo.html) 22:13:59 INFO - PROCESS | 28100 | __metrics Screen width/height:1600/1200 22:13:59 INFO - PROCESS | 28100 | colorDepth:24 22:13:59 INFO - PROCESS | 28100 | Browser inner width/height: 1024/697 22:13:59 INFO - PROCESS | 28100 | __metrics 22:13:59 INFO - PROCESS | 28100 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:13:59 INFO - PROCESS | 28100 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:14:00 INFO - TEST-INFO | 28100: exit 0 22:14:00 INFO - Browser initialized. 22:14:00 INFO - Running cycle 1/1 for v8_7 test... 22:14:00 INFO - TEST-INFO | started process 28182 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7JadFv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:14:12 INFO - PROCESS | 28182 | RSS: Main: 149721088 22:14:12 INFO - PROCESS | 28182 | 22:14:33 INFO - PROCESS | 28182 | Cycle 1(1): loaded http://localhost:41729/tests/v8_7/run.html (next: http://localhost:41729/tests/v8_7/run.html) 22:14:33 INFO - PROCESS | 28182 | RSS: Main: 571564032 22:14:33 INFO - PROCESS | 28182 | 22:14:33 INFO - PROCESS | 28182 | __start_tp_report 22:14:33 INFO - PROCESS | 28182 | _x_x_mozilla_page_load 22:14:33 INFO - PROCESS | 28182 | _x_x_mozilla_page_load_details 22:14:33 INFO - PROCESS | 28182 | |i|pagename|runs| 22:14:33 INFO - PROCESS | 28182 | |0;Richards;168.77637130801688 22:14:33 INFO - PROCESS | 28182 | |1;DeltaBlue;190.83969465648855 22:14:33 INFO - PROCESS | 28182 | |2;Encrypt;283.12570781426956 22:14:33 INFO - PROCESS | 28182 | |3;Decrypt;5218.75 22:14:33 INFO - PROCESS | 28182 | |4;RayTrace;1133.7868480725624 22:14:33 INFO - PROCESS | 28182 | |5;Earley;787.4015748031496 22:14:33 INFO - PROCESS | 28182 | |6;Boyer;11929.411764705883 22:14:33 INFO - PROCESS | 28182 | |7;RegExp;25666.666666666668 22:14:33 INFO - PROCESS | 28182 | |8;Splay;649.3506493506494 22:14:33 INFO - PROCESS | 28182 | |9;NavierStokes;4845.410628019324 22:14:33 INFO - PROCESS | 28182 | __end_tp_report 22:14:33 INFO - PROCESS | 28182 | __startTimestamp1450764873768__endTimestamp 22:14:33 INFO - PROCESS | 28182 | 22:14:33 INFO - PROCESS | 28182 | ------- Summary: start ------- 22:14:33 INFO - PROCESS | 28182 | Number of tests: 10 22:14:33 INFO - PROCESS | 28182 | 22:14:33 INFO - PROCESS | 28182 | [#0] Richards Cycles:1 Average:168.78 Median:168.78 stddev:0.00 (0.0%) 22:14:33 INFO - PROCESS | 28182 | Values: 168.8 22:14:33 INFO - PROCESS | 28182 | 22:14:33 INFO - PROCESS | 28182 | [#1] DeltaBlue Cycles:1 Average:190.84 Median:190.84 stddev:0.00 (0.0%) 22:14:33 INFO - PROCESS | 28182 | Values: 190.8 22:14:33 INFO - PROCESS | 28182 | 22:14:33 INFO - PROCESS | 28182 | [#2] Encrypt Cycles:1 Average:283.13 Median:283.13 stddev:0.00 (0.0%) 22:14:33 INFO - PROCESS | 28182 | Values: 283.1 22:14:33 INFO - PROCESS | 28182 | 22:14:33 INFO - PROCESS | 28182 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 22:14:33 INFO - PROCESS | 28182 | Values: 5218.8 22:14:33 INFO - PROCESS | 28182 | 22:14:33 INFO - PROCESS | 28182 | [#4] RayTrace Cycles:1 Average:1133.79 Median:1133.79 stddev:0.00 (0.0%) 22:14:33 INFO - PROCESS | 28182 | Values: 1133.8 22:14:33 INFO - PROCESS | 28182 | 22:14:33 INFO - PROCESS | 28182 | [#5] Earley Cycles:1 Average:787.40 Median:787.40 stddev:0.00 (0.0%) 22:14:33 INFO - PROCESS | 28182 | Values: 787.4 22:14:33 INFO - PROCESS | 28182 | 22:14:33 INFO - PROCESS | 28182 | [#6] Boyer Cycles:1 Average:11929.41 Median:11929.41 stddev:0.00 (0.0%) 22:14:33 INFO - PROCESS | 28182 | Values: 11929.4 22:14:33 INFO - PROCESS | 28182 | 22:14:33 INFO - PROCESS | 28182 | [#7] RegExp Cycles:1 Average:25666.67 Median:25666.67 stddev:0.00 (0.0%) 22:14:33 INFO - PROCESS | 28182 | Values: 25666.7 22:14:33 INFO - PROCESS | 28182 | 22:14:33 INFO - PROCESS | 28182 | [#8] Splay Cycles:1 Average:649.35 Median:649.35 stddev:0.00 (0.0%) 22:14:33 INFO - PROCESS | 28182 | Values: 649.4 22:14:33 INFO - PROCESS | 28182 | 22:14:33 INFO - PROCESS | 28182 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 22:14:33 INFO - PROCESS | 28182 | Values: 4845.4 22:14:33 INFO - PROCESS | 28182 | -------- Summary: end -------- 22:14:33 INFO - PROCESS | 28182 | 22:14:34 INFO - TEST-INFO | 28182: exit 0 22:14:34 INFO - TEST-OK | v8_7 | took 39220ms 22:14:34 INFO - SUITE-END | took 1211s 22:14:34 INFO - Completed test suite (00:20:11) 22:14:34 INFO - Working with test: dromaeo_css 22:14:34 INFO - Generating results file: dromaeo_css 22:14:34 INFO - Working with test: kraken 22:14:34 INFO - Generating results file: kraken 22:14:34 INFO - javascript benchmark 22:14:34 INFO - Working with test: v8_7 22:14:34 INFO - Generating results file: v8_7 22:14:34 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:14:34 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,35]] 22:14:34 INFO - process_Request line: dromaeo_css 6859.25 graph.html#tests=[[72,63,35]] 22:14:34 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:14:34 INFO - process_Request line: kraken 1508.00 graph.html#tests=[[232,63,35]] 22:14:34 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:14:34 INFO - process_Request line: v8_7 20808.76 graph.html#tests=[[230,63,35]] 22:14:34 INFO - RETURN: dromaeo_css: 6859.25 22:14:34 INFO - RETURN: kraken: 1508.00 22:14:34 INFO - RETURN: v8_7: 20808.76 22:14:34 INFO - javascript benchmark 22:14:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3096.7677424193184, 3131.514615234639, 3201.6638252983435, 3202.9999999999986, 3227.7256433203183, 5096.515830996059, 5227.424983251849, 5289.497497737713, 5349.331333583302, 5387.703676297807, 5251.396089449705, 5267.52592266696, 5310.256564081032, 5323.547498462625, 5378.569714422846, 4770.260609605517, 4788.281757736333, 4790.520947905216, 4809.350737650425, 4896.510348965111, 4838.709677419349, 4911.165101932662, 4915.459299477055, 4943.3172286646495, 5000.299958005882, 4721.197396442596, 4743.0988112258565, 4842.370491836074, 4847.757612119415, 4908.705477671333, 4828.299896515021, 4843.782029808667, 4851.951480485185, 4854.029194161182, 4866.270059491069, 4794.640401969867, 4803.615710743167, 4811.735354555498, 4819.1325561398935, 4866.367372241586, 5029.673071250357, 5133.383993920716, 5142.897142057138, 5146.871328216787, 5151.04705629456, 5658.773649054033, 5721.5708821838525, 5731.713414329267, 5779.104238842986, 5785.942140578582, 5768.913466298009, 5781.913271300934, 5805.796797112123, 5808.361080281165, 5809.2447981762525, 5113.693178409233, 5216.66091704038, 5408.864778380533, 5427.158790387457, 5430.0, 5697.202391665171, 5705.5150312223095, 5721.4278572143285, 5727.255456790591, 5765.88468230633, 5554.944450555524, 5556.638818476786, 5559.249501317351, 5609.4390560943575, 5610.691411972299, 5516.806911758069, 5597.188407680864, 5620.016497112989, 5651.813119244923, 5711.657300561979, 5555.916661250085, 5585.748641311069, 5611.579131565068, 5627.943720562824, 5629.521490673257, 5619.7471113799975, 5620.297462817148, 5620.91568626471, 5620.971895140498, 5624.690642014729, 4212.684048696298, 4311.396404503372, 4373.278409062469, 4374.081442897027, 4418.889527761831, 3831.4061320495366, 3872.7482713623526, 3873.65137137659, 3910.7262491625315, 3916.1971795782365, 5325.121354976385, 5328.200769884548, 5329.840104796862, 5330.493603107699, 5375.919361209585, 5482.068048431776, 5599.468050535274, 5601.187827765033, 5691.345495268014, 5709.914351284734, 5328.49379308965, 5440.700761458158, 5447.918281225785, 5458.235846981426, 5461.890762184734, 4966.205407134841, 4976.253561965662, 4999.0501804657, 5002.274670172805, 5032.622553308516, 5685.744141513559, 5746.42535746422, 5755.597108202385, 5756.42435756421, 5764.74058667361, 5450.672959622435, 5555.166724991283, 5576.609637325349, 5604.551635869039, 5780.624259423124, 5710.971445142748, 5726.599138060463, 5731.455511726379, 5756.94243057564, 5817.738201781015, 5618.129189975397, 5622.5501959842295, 5627.662340259598, 5635.323761148688, 5637.126245431965, 5522.2544956431975, 5583.944160558342, 5617.382087970238, 5687.601867869375, 5829.242198514166, 5573.191887176417, 5625.943740562706, 5644.85887852807, 5645.0, 5655.377908429987, 5599.748011339418, 5604.579656525695, 5617.101263797773, 5617.522510586482, 5617.691026993554, 5217.399999000164, 5326.680399176062, 5342.0, 5349.893002140013, 5478.342598888159, 5623.775048997994, 5629.915551266652, 5633.295838020247, 5642.0, 5682.977064128331, 5513.173024046425, 5519.613627046068, 5523.6409633373705, 5524.751386187711, 5535.723213839211], "unit": "score", "name": "dojo.html", "value": 5229.037144162812}, {"lowerIsBetter": false, "replicates": [561.2227065514262, 604.6009633641797, 604.6825416656252, 609.945104940555, 616.6207782213937, 29085.41829163418, 29101.272468188305, 29558.704412955864, 29607.555886661692, 37844.0, 41254.58745412545, 42021.7898910505, 42037.0, 42040.0, 42074.158516829724, 8521.659133634663, 8685.739427817143, 8722.476651400904, 8728.650853965866, 8732.563371831415, 7216.855662886739, 7337.743178988737, 8474.322054235678, 8585.270252028586, 10174.898251017468, 10056.0, 10132.746681332988, 10175.694729158136, 10177.287589868713, 10180.083792458678, 10001.59993600255, 10075.143612792921, 10076.798464030679, 10081.19350451962, 10089.949550252202, 7653.464257501977, 7843.7254696085365, 7845.76462706114, 10455.424951627658, 10721.678349649523, 39081.41377879334, 39403.211935761414, 39419.0, 39452.21095578101, 39502.209955800725, 3116.2832548513743, 3123.2972581169283, 3226.080567038383, 3295.505674148873, 3527.576690797095, 29120.271993200127, 30027.549586756217, 30312.84248281346, 30325.24186895323, 30416.8479157605, 3827.2585973382043, 3853.113783829735, 3853.2678791029616, 3941.1329507508303, 3947.4670919426085, 265256.0, 266337.0, 266408.6679566609, 266550.0, 267175.0, 53724.46275537195, 54684.437867455366, 55499.44500555024, 55780.44219557834, 55937.72031139818, 60236.39763602308, 60309.98450077567, 60725.39274607286, 60941.69529152326, 61080.69459652673, 14178.361973711208, 14328.49850255236, 14383.065100768417, 14384.496542620958, 14400.351984160738, 11067.114630829514, 11082.501287442085, 11142.331460112257, 11143.108551315876, 11143.72140696489, 18306.450806475827, 18475.0, 18488.0, 18495.352662656744, 18630.906845465684, 7525.4355923305975, 7715.652795624211, 7748.961255193688, 7764.3788496920115, 7822.882656760153, 896.7489103051156, 931.2689538712078, 938.9530523473799, 960.2462067277154, 1067.3169171730099, 27726.44547109087, 27804.58293125605, 27919.58120628192, 28130.859345703142, 28268.43463130726, 1022.2384323678758, 1025.8204814157493, 1050.821360368739, 1059.6715018344185, 1147.1052578988401, 14500.129992200502, 14594.781078283835, 14721.190334531704, 14875.851241487662, 14881.181535015461, 320605.0, 326360.0, 326461.0, 326631.0, 327592.0, 50258.96374507572, 50282.0, 50312.49687503078, 50441.24338134931, 50586.747066264434, 1195.0738177912187, 1242.881926217026, 1260.3068312428127, 1283.3134273163625, 1288.1948782011243, 26430.471390571696, 27167.45665086727, 27398.72601273962, 27440.0, 27794.5830812542, 41267.7936610327, 44730.77634611806, 45008.77495612632, 45081.549184507734, 45124.32313515365, 212093.0, 399995.0, 409899.0, 410116.0, 410601.0, 28975.7102428973, 29372.18161638973, 29456.263593410335, 29480.262993425335, 29517.409651807273, 38990.610093899835, 40413.59586404216, 40524.79737601411, 40755.0, 40823.0, 34086.31827363389, 34231.48652770161, 34281.657183427844, 34615.653843461245, 35461.46807797936, 34165.7524683351, 34658.65341346655, 34699.306013879075, 34859.82570087133, 35090.298194036484, 33050.83474582612, 33583.0, 33866.153346166546, 33922.83038584791, 33938.66061339355, 29676.0, 31103.377932441676, 31184.53223201699, 31524.52713209258, 31631.36737265288, 23587.646185307578, 23683.289501314986, 23770.0, 23970.40073998094, 24286.75713242845], "unit": "score", "name": "ext.html", "value": 18156.27567502773}, {"lowerIsBetter": false, "replicates": [356.4920386763987, 358.2423174984907, 360.7348598779896, 363.74719569898923, 364.13154626216465, 13544.72910541791, 13768.931155344235, 16237.675246495062, 16507.669846603076, 17183.140842957848, 10661.786764264729, 12373.752524949496, 13108.0, 15796.289166987484, 15802.920985395085, 4756.90486190276, 4812.23004319309, 4875.512448755132, 4876.707397556141, 4900.9754951225195, 3763.1344790698154, 4881.8291359802415, 4906.043321552299, 4906.950930490703, 5002.299678045077, 5359.249705041298, 5394.109971854659, 5427.050266203419, 5449.509544141027, 5460.672359658413, 5065.594752419797, 5199.220116982483, 5394.514493695567, 5406.99999999998, 5410.783568657249, 5017.222330538772, 5018.924716129224, 5020.497950204986, 5022.84931452057, 5024.120778863684, 19034.14487826823, 20043.498912527157, 20100.899495502574, 20613.4846628834, 21155.576888462143, 2018.3586330703445, 2109.715188449555, 2113.894305284745, 2160.546285280093, 2190.080166330129, 9228.0, 9311.115444032806, 9400.811983760286, 11164.553417863275, 13341.86658133416, 1803.1885651456896, 1832.7800663920416, 1867.6451474219855, 1885.70771530413, 1893.195391958426, 57458.44782103522, 60705.0, 62085.37914620886, 62613.686931565506, 63082.0, 9566.66516671913, 9947.602095916081, 10050.547725352377, 10072.143867771321, 10106.747331316628, 12797.744045119232, 12937.805932911015, 12954.935225323814, 12961.41673624689, 12974.481020759253, 7031.929680703128, 7307.89038164428, 7360.815979600553, 7492.950986861843, 7559.3196612304055, 7153.89269160963, 7209.2069872314005, 7245.203027666952, 7318.268173182639, 7415.40676745859, 4278.4865816102265, 4366.19225443294, 4406.691531592758, 4446.510883802779, 4537.274036154199, 1671.8746094042995, 1718.2869109319743, 1812.4109664358873, 1831.5787368905226, 1867.4957761404344, 379.93541098013407, 382.3519135066092, 756.4364548411469, 932.47315266874, 951.9476428796482, 9530.142287194047, 15439.61400964985, 17496.83136894825, 17948.37180698669, 18369.173387197607, 837.8785076163922, 861.3410740783306, 894.190757364586, 899.0559912092277, 948.6300342866288, 9062.682806101755, 9466.337356385126, 9537.2370210383, 9627.518624068769, 9676.0, 511232.7643959236, 532452.0, 536130.0, 538576.0, 549318.0, 78894.0, 79785.60107199544, 79903.0, 80785.59607201927, 82442.17557824466, 1116.0792346314324, 1118.0384869012642, 1128.9830652540218, 1130.3895896216115, 1135.5571327182406, 14983.0, 15067.698646027236, 15160.696786063996, 15165.317560710015, 15337.309821058303, 34692.82653586817, 34860.0, 34881.1166436694, 35051.474227886094, 35575.82212088923, 46325.30512042255, 46682.76658616685, 47281.76359118182, 47518.28722569234, 47722.0, 9176.632934682539, 9402.2948278878, 9449.669261576088, 9455.101765332283, 9457.10157535033, 10415.1667866572, 10438.68683939483, 15154.16652084146, 16329.183540823149, 17317.393891213746, 11442.199046067028, 11733.647990560297, 13456.56560623809, 14982.625434364229, 15049.77425338599, 13257.204567725967, 13923.512677056255, 14007.299635018413, 14152.575422737335, 14498.347574358968, 14351.425942962582, 14418.855811441752, 14581.416743330148, 14612.19632920157, 14630.487932922297, 9152.816943661222, 9175.403598766326, 9353.345265831327, 9594.760130996781, 9634.71095867125, 9851.45816980073, 11475.885241147482, 14205.928970355082, 14754.778678319619, 14796.926015369854], "unit": "score", "name": "jquery.html", "value": 8525.916255411634}, {"lowerIsBetter": false, "replicates": [1204.0728638948005, 1713.742938559216, 1743.494386627878, 1749.9912500437497, 1770.876038677293, 6377.776777812777, 7195.352418282354, 7344.96327518363, 7352.0, 7369.410447164228, 7427.0, 7596.582187979659, 7622.504537205078, 7629.580373079479, 7637.961810190941, 1923.8364738997202, 1949.2592814730383, 1951.248769223852, 2224.833137514685, 2268.421552504109, 2235.228846048111, 2260.107257633234, 2268.1494439585153, 2276.46503071778, 2276.8633881967135, 2160.157538559963, 2196.6924630551734, 2227.7103976483036, 2228.22012295696, 2230.241717815942, 2179.1719146724304, 2243.3270018994317, 2274.8293877959136, 2276.5560715660454, 2279.8290128240365, 2245.7529671736097, 2253.3577930289953, 2290.5647926893835, 2291.747907730148, 2294.8393612447135, 7476.14024387197, 7488.251174882523, 7488.363489103433, 7500.962495187489, 7590.962045189794, 4545.613622842063, 4648.442186937556, 4682.6019788318035, 4710.69380490267, 4712.95287047132, 3002.24943764059, 3090.443720130398, 3121.78147529673, 3153.3220357623222, 3156.163616641592, 943.1181844974902, 948.7722946492861, 974.9853752193723, 1014.6854475112739, 1023.4013102335143, 10262.281640285182, 10320.79358412835, 10343.120834729058, 10391.688249352532, 10420.531076101593, 3948.1511475033008, 4033.858814941463, 4061.939070913939, 4067.877963661095, 4096.569860164699, 8118.391120665856, 8142.063662678749, 8151.5109093454585, 8154.306883914815, 8159.184081591793, 4517.977410112994, 4527.61515271199, 4547.181507328646, 4569.246074397754, 4571.3600095986585, 4190.811413486401, 4224.957750422518, 4233.238017156941, 4238.554951730024, 4243.236217480821, 3137.13728724598, 3168.603924509436, 3220.2271454850666, 3391.9660803392144, 3506.4564992426212, 1093.1965005720788, 1095.5343978808974, 1099.2580008494235, 1102.5369344875012, 1111.4165063341811, 891.2112780189449, 973.9902600974041, 974.1281553010016, 1038.5222797513077, 1283.9743205135844, 7126.5011449198055, 7169.24722904098, 7171.964140179266, 7174.210836807947, 7179.174394944544, 585.8183962971492, 589.9911501327483, 604.7913469852894, 604.803438882365, 729.8650598319664, 5628.380878103405, 5628.409017053233, 5668.7165641718575, 5673.886522269531, 5710.600257981901, 8932.732018039469, 8975.192232699088, 9020.819583608421, 9149.130832570896, 9160.175584197454, 8990.100989901088, 9056.818863622691, 9077.228435582918, 9084.682036128705, 9101.772455688528, 7073.787786366417, 7108.68010939509, 7183.317584829538, 7183.604901730455, 7183.92816071843, 6823.1812182538415, 6867.381935625618, 6886.965565172142, 6897.379235868796, 6904.3095690432565, 7961.402894782798, 8047.758567242992, 8104.716334928485, 8239.0, 8256.380771442286, 8196.057453392936, 8357.623906924082, 8476.321894248322, 8484.278836298983, 8490.363222758442, 6413.16628838248, 6417.294097649162, 6420.454261387647, 6451.032345148265, 6523.67381630907, 6430.164078669743, 6629.303923088007, 6805.3875151236625, 7409.518381305198, 7439.479236453396, 6679.06493090958, 6714.227863795726, 6828.419584335387, 6868.416184624363, 6938.098047253825, 6621.966890165519, 6655.567388119756, 6682.031105489774, 6744.662766861736, 6753.459723222229, 6784.287649796897, 6787.592744435349, 6790.083338749206, 6793.2867048961125, 6810.931890681228, 6258.62448253088, 6288.245410550763, 6297.905531417124, 6310.7475700971445, 6316.905246421399, 6115.449609535163, 6338.524610654312, 6359.8092057238355, 6368.267649220399, 6373.203349581302], "unit": "score", "name": "mootools.html", "value": 4262.676882551641}, {"lowerIsBetter": false, "replicates": [329.8779451602907, 331.64679616208736, 336.2820378491919, 340.6661471757677, 344.8206932395153, 5846.6199697019665, 5881.323647780507, 5923.200367950325, 5937.22816033916, 5982.102684597313, 5586.441355864422, 5656.802011929583, 5765.365809760923, 5854.912176317348, 5892.204552385427, 4505.301678239862, 4505.504394516601, 4508.481524624661, 4511.0, 4514.187446259672, 4246.7027308088445, 4515.803312122291, 4525.47956984946, 4527.52460991596, 4540.228161212602, 4304.246756817544, 4407.889802754925, 4493.191225579394, 4500.122476117159, 4524.411826462555, 4471.262241730111, 4496.482904465979, 4498.100379923995, 4507.977460112695, 4514.864554063383, 3971.6028397160344, 3977.8011099445202, 3983.103801644636, 3984.2629113614075, 3987.521497420328, 5514.172874068881, 5590.329160500766, 5592.972035139798, 5600.355959064719, 5600.747966341483, 5253.605979551511, 5262.868428289324, 5263.157894736862, 5263.842084737464, 5264.341957255343, 6204.379562043805, 6212.72042758077, 6213.347598502182, 6223.3776622337855, 6225.159603453566, 4400.603945644907, 4401.603855653007, 4409.470863496369, 4411.029573493826, 4421.850318917072, 6312.747490100436, 6472.352764723537, 6474.125992990933, 6476.352364763533, 6485.5460117792245, 4506.932396014063, 4507.459104907432, 4508.346289787963, 4517.570830771071, 4519.344695019204, 4496.820127194941, 4555.339475775994, 4560.521145279764, 4564.543545645475, 4564.817407303737, 5232.162853943427, 5232.764525596357, 5233.71214583194, 5236.9738151309, 5242.868928276824, 6162.22972128484, 6260.5617606768, 6266.122742816009, 6279.748810047547, 6282.2147231596055, 1590.90454572726, 1599.896006759557, 1600.1439230011888, 1608.035178892655, 1609.050660110517, 1105.1048650593045, 1111.0389513071136, 1113.8607674040745, 1124.7413094988199, 1133.8582677165355, 6045.1234570987845, 6046.969765151146, 6052.182955301066, 6052.788152414644, 6064.818055458343, 6484.027395890655, 6490.2536208335705, 6501.512386571026, 6508.446782023487, 6515.902261466082, 5865.941340586625, 5956.404359564096, 6015.819525414245, 6119.632822030692, 6124.203853499017, 3517.2613751112553, 3539.0975301298004, 3540.274243780019, 3551.804650744234, 3551.9289614207573, 6646.800595982031, 6654.201495820533, 6659.6670166491485, 6666.699998500079, 6686.866262674719, 6556.213254409501, 6667.299933507009, 6672.9332706673285, 6675.332466753286, 6686.498512611476, 6660.666966651648, 6666.466682665375, 6666.533342665967, 6677.53257271996, 6683.866322673519, 6528.6735663215695, 6549.115869357575, 6550.213974323112, 6556.082148499118, 6560.639164845979, 6320.209973753281, 6483.448906842971, 6484.70818813164, 6490.831650302802, 6495.350464953467, 6656.83357916056, 6660.966695166493, 6668.199816022108, 6679.465642748665, 6687.565308254948, 4474.485434175112, 4476.776161191992, 4478.0, 4479.372887795646, 4486.10277944419, 6409.551331406757, 6550.377714117342, 6555.410013098844, 6557.672116394066, 6562.34376562359, 6368.299487056327, 6370.936290637034, 6375.904361434489, 6382.776602818879, 6394.84892719315, 6347.174867267226, 6358.682065896594, 6361.395667411589, 6366.076918846648, 6367.936320636734, 6015.368386319374, 6141.048137538689, 6181.320054794059, 6199.814005579839, 6214.4407003369915, 6381.329960354096, 6391.105245265573, 6393.6163830170335, 6402.10370548133, 6403.0715546246465, 6215.160953271251, 6230.50155987529, 6234.6570938597, 6238.438540531374, 6239.282482514569], "unit": "score", "name": "prototype.html", "value": 4752.082814286246}, {"lowerIsBetter": false, "replicates": [750.5571712689513, 816.8849520404646, 817.2738363270289, 818.4925346285304, 856.1695155698969, 12998.285094319821, 13313.866861331384, 13318.334083295846, 13327.533536326231, 13400.262985535792, 12727.0, 12732.172408793422, 12738.426770795313, 12890.097693161459, 12914.418851151697, 673.6699017481424, 680.068306420205, 810.2909953790448, 817.8568750468673, 817.9386546009043, 819.7991492084448, 821.9301359384459, 827.4332082523491, 827.93790465715, 828.329053466694, 857.5069335132292, 869.2046777198887, 869.5912920927186, 870.8954925408959, 873.1225118755674, 714.0324859814954, 714.7391202211181, 847.3560094328293, 864.9351298652626, 866.3372520022189, 630.2846269484123, 632.1939527102935, 634.9713464188045, 635.0030452190064, 635.3931994944817, 12957.935210323889, 13026.80459793104, 13045.152065115737, 13104.86895131046, 13286.86713132866, 11543.422828858607, 11554.306741595447, 11917.642470725892, 12157.392130393446, 12383.442745076492, 10393.545397008967, 10492.632757853438, 10608.257421980465, 10774.730631734192, 10827.512761925733, 3512.543369361992, 3578.8210589470423, 3621.0947263184203, 3626.34725749365, 3682.815859207029, 44232.778836105936, 44372.0, 44383.0, 44394.33408498875, 44606.776966115285, 9582.472963987047, 9646.469444180497, 9650.324477286522, 9658.130768230892, 9788.902110978941, 17447.65104697899, 17466.0, 17557.82442175562, 17561.824381756276, 17569.209385577426, 7458.552486850698, 7502.062242219723, 7596.81007974794, 7729.806754831175, 7932.881006784903, 4252.255855225323, 4300.80646370914, 4344.869653910388, 4415.116976604692, 4425.468943726709, 3258.885938992124, 3274.5743053402907, 3283.4089863824265, 3294.950575741366, 3298.340331933623, 679.6363945289345, 682.4438082962469, 684.7089986755609, 694.9409300209438, 701.0465766557478, 567.4807551090788, 647.873664635401, 673.8854394752904, 690.2579726793717, 702.9789106326818, 8923.40733711263, 8952.910470895338, 9093.181613654802, 9128.22410095136, 9155.404898681565, 545.7298637174624, 549.5164255455173, 550.9228707980886, 599.8320470268332, 656.6191608866845, 3628.6552777486095, 3722.6277372262557, 3765.0, 3788.7726736395903, 3999.9002767320917, 58883.41116588865, 60204.0, 60276.09585856128, 60416.093758593655, 60443.69778151169, 52532.737336313076, 52848.735756321745, 53129.0, 53466.73266633642, 54245.0, 46446.0, 46618.76690616525, 47367.52632473631, 47497.28754068692, 48630.75684621554, 8549.358798090292, 8606.483610983361, 8744.519051452231, 8812.86780698303, 8867.379283450096, 34351.65648343485, 34575.13562160966, 34817.65182348144, 35363.0, 35416.64583354133, 41469.58530414778, 41531.792341038104, 42437.78781106075, 45037.32444013277, 45693.54306456893, 10745.838812417664, 11058.22592418523, 11149.72125696864, 11304.83042754343, 11649.41752912334, 12136.878631213927, 12178.0, 12416.565420210249, 12707.80938285945, 12806.423710932844, 11688.88311116878, 11716.355600442057, 11730.70673233176, 11963.700907477383, 12190.817137742764, 11303.660890173307, 11410.543578256777, 11566.94216528912, 11891.82162267584, 11902.285862848257, 11807.350595717318, 12160.635180944586, 12179.39103044862, 12241.938790305992, 12606.306653134166, 10102.667362716407, 10211.846822297523, 10299.639512617023, 10622.0, 10867.619633313112, 9347.766305842408, 9520.868304783502, 9624.566894489624, 10077.9169052302, 10217.0], "unit": "score", "name": "yui.html", "value": 6351.30132119031}], "name": "dromaeo_css", "value": 6859.246209204675}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 105.0, 111.0, 112.0, 112.0, 101.0, 110.0, 111.0, 115.0], "unit": "score", "name": "ai-astar", "value": 109.8}, {"lowerIsBetter": true, "replicates": [151.0, 124.0, 148.0, 162.0, 125.0, 150.0, 157.0, 125.0, 163.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 143.1}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 161.0, 163.0, 161.0, 163.0, 160.0, 164.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 90.0, 96.0, 74.0, 71.0, 73.0, 99.0, 95.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 138.0, 93.0, 94.0, 94.0, 139.0, 95.0, 94.0, 138.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 147.0, 148.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 57.0, 56.0, 56.0, 57.0, 58.0, 67.0, 54.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 67.0, 69.0, 68.0, 68.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [85.0, 85.0, 85.0, 86.0, 85.0, 86.0, 87.0, 93.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [129.0, 124.0, 116.0, 124.0, 121.0, 127.0, 119.0, 126.0, 125.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.3}, {"lowerIsBetter": true, "replicates": [143.0, 140.0, 151.0, 163.0, 153.0, 145.0, 156.0, 149.0, 151.0, 153.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.4}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1507.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.77637130801688], "unit": "score", "name": "Richards", "value": 209.1643499999999}, {"lowerIsBetter": false, "replicates": [190.83969465648855], "unit": "score", "name": "DeltaBlue", "value": 346.45831999999996}, {"lowerIsBetter": false, "replicates": [283.12570781426956], "unit": "score", "name": "Encrypt", "value": 940.1512919999999}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [1133.7868480725624], "unit": "score", "name": "RayTrace", "value": 652.6702980000001}, {"lowerIsBetter": false, "replicates": [787.4015748031496], "unit": "score", "name": "Earley", "value": 846.4080099999996}, {"lowerIsBetter": false, "replicates": [11929.411764705883], "unit": "score", "name": "Boyer", "value": 55.867214003944795}, {"lowerIsBetter": false, "replicates": [25666.666666666668], "unit": "score", "name": "RegExp", "value": 35.49292207792205}, {"lowerIsBetter": false, "replicates": [649.3506493506494], "unit": "score", "name": "Splay", "value": 125.49613999999997}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 20808.75798754972}]} 22:14:34 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,35]]", "result": "20808.76"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,35]]", "result": "1508.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,35]]", "result": "6859.25"}}} 22:14:34 INFO - Return code: 0 22:14:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 22:14:35 ERROR - # TBPL SUCCESS # 22:14:35 INFO - Running post-action listener: _resource_record_post_action 22:14:35 INFO - Running post-run listener: _resource_record_post_run 22:14:36 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 546918400; Read time: 16; Write time: 422192 22:14:36 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 235184128; Read time: 0; Write time: 225268 22:14:36 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 311734272; Read time: 16; Write time: 196924 22:14:36 INFO - Running post-run listener: _upload_blobber_files 22:14:36 INFO - Blob upload gear active. 22:14:36 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 22:14:36 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 22:14:36 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'] 22:14:36 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 22:14:36 INFO - (blobuploader) - INFO - Open directory for files ... 22:14:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:14:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:14:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:14:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:14:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:14:37 INFO - (blobuploader) - INFO - Done attempting. 22:14:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 22:14:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:14:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:14:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:14:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:14:38 INFO - (blobuploader) - INFO - Done attempting. 22:14:38 INFO - (blobuploader) - INFO - Iteration through files over. 22:14:38 INFO - Return code: 0 22:14:38 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 22:14:38 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 22:14:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a9913661dbeeb685d0cbdc11bac00cd8d53beb0c9557bfdad755a5697350b8f6c0eb518d1eb847e281352d08918eedf6ecd2984533e8642f15975fe2fb93e094", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8c4dee48b95e94ef3750d34221bd931ab25a2318253298d9cfdb484ee74a2bdd9eff2802441b6b316bd3f6ee9904913a39b8d3fcf509cc27960d3c6bc09417a8"} 22:14:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 22:14:38 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 22:14:38 INFO - Contents: 22:14:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a9913661dbeeb685d0cbdc11bac00cd8d53beb0c9557bfdad755a5697350b8f6c0eb518d1eb847e281352d08918eedf6ecd2984533e8642f15975fe2fb93e094", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8c4dee48b95e94ef3750d34221bd931ab25a2318253298d9cfdb484ee74a2bdd9eff2802441b6b316bd3f6ee9904913a39b8d3fcf509cc27960d3c6bc09417a8"} 22:14:38 INFO - Copying logs to upload dir... 22:14:38 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.869669 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-21 22:14:37.344678) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 22:14:37.348522) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a9913661dbeeb685d0cbdc11bac00cd8d53beb0c9557bfdad755a5697350b8f6c0eb518d1eb847e281352d08918eedf6ecd2984533e8642f15975fe2fb93e094", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8c4dee48b95e94ef3750d34221bd931ab25a2318253298d9cfdb484ee74a2bdd9eff2802441b6b316bd3f6ee9904913a39b8d3fcf509cc27960d3c6bc09417a8"} build_url:https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011453 build_url: 'https://queue.taskcluster.net/v1/task/O0Zo4lcKSmq2CP8EIOmXvw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a9913661dbeeb685d0cbdc11bac00cd8d53beb0c9557bfdad755a5697350b8f6c0eb518d1eb847e281352d08918eedf6ecd2984533e8642f15975fe2fb93e094", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/8c4dee48b95e94ef3750d34221bd931ab25a2318253298d9cfdb484ee74a2bdd9eff2802441b6b316bd3f6ee9904913a39b8d3fcf509cc27960d3c6bc09417a8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 22:14:37.373533) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:14:37.373883) ========= 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=bab59de71505bdac5bb1aeb2000001b6-1450755579.148567-685101478 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 22:14:37.458892) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 22:14:37.459211) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 22:14:37.459492) ========= ========= Total master_lag: 0.23 =========