builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1450752391.47 results: success (0) buildid: 20151221163010 builduid: 791f1247ac2240de881ee7ee8d1c195a revision: ae5acd5505a0086aa9773649968cc969064819bc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:31.471136) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:31.471667) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:31.471961) ========= 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=820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006285 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:31.497293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:31.497814) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:31.527985) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:31.528408) ========= 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=820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003568 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:31.575471) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:31.575784) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:31.576153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:31.576451) ========= 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=820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 18:46:31-- 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% 221M=0s 2015-12-21 18:46:31 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182230 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:31.772347) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:31.772811) ========= 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=820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.069934 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:31.854962) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:31.855595) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev ae5acd5505a0086aa9773649968cc969064819bc --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 ae5acd5505a0086aa9773649968cc969064819bc --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=820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 18:46:32,114 truncating revision to first 12 chars 2015-12-21 18:46:32,114 Setting DEBUG logging. 2015-12-21 18:46:32,114 attempt 1/10 2015-12-21 18:46:32,114 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/ae5acd5505a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 18:46:32,376 unpacking tar archive at: mozilla-inbound-ae5acd5505a0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.573363 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:32.442696) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:32.442998) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:32.453023) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:32.453373) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 18:46:32.453834) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-21 18:46:32.454117) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:46:32 INFO - MultiFileLogger online at 20151221 18:46:32 in /builds/slave/test-pgo 18:46:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:46:32 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 18:46:32 INFO - {'append_to_log': False, 18:46:32 INFO - 'base_work_dir': '/builds/slave/test-pgo', 18:46:32 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:46:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 18:46:32 INFO - 'branch': 'Mozilla-Inbound', 18:46:32 INFO - 'buildbot_json_path': 'buildprops.json', 18:46:32 INFO - 'config_files': ('talos/linux_config.py',), 18:46:32 INFO - 'default_actions': ('clobber', 18:46:32 INFO - 'read-buildbot-config', 18:46:32 INFO - 'download-and-extract', 18:46:32 INFO - 'populate-webroot', 18:46:32 INFO - 'create-virtualenv', 18:46:32 INFO - 'install', 18:46:32 INFO - 'run-tests'), 18:46:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:46:32 INFO - 'download_minidump_stackwalk': True, 18:46:32 INFO - 'download_symbols': 'ondemand', 18:46:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:46:32 INFO - 'tooltool.py': '/tools/tooltool.py', 18:46:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:46:32 INFO - '/tools/misc-python/virtualenv.py')}, 18:46:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:46:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:46:32 INFO - 'installer_path': 'installer.exe', 18:46:32 INFO - 'log_level': 'info', 18:46:32 INFO - 'log_name': 'talos', 18:46:32 INFO - 'log_to_console': True, 18:46:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:46:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:46:32 INFO - 'opt_config_files': (), 18:46:32 INFO - 'pip_index': False, 18:46:32 INFO - 'sps_profile': False, 18:46:32 INFO - 'sps_profile_interval': 0, 18:46:32 INFO - 'suite': 'dromaeojs-e10s', 18:46:32 INFO - 'system_bits': '64', 18:46:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:46:32 INFO - 'title': 'talos-linux64-ix-055', 18:46:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:46:32 INFO - 'use_talos_json': True, 18:46:32 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 18:46:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:46:32 INFO - 'work_dir': 'build'} 18:46:32 INFO - ##### 18:46:32 INFO - ##### Running clobber step. 18:46:32 INFO - ##### 18:46:32 INFO - Running pre-action listener: _resource_record_pre_action 18:46:32 INFO - Running main action method: clobber 18:46:32 INFO - rmtree: /builds/slave/test-pgo/build 18:46:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 18:46:34 INFO - Running post-action listener: _resource_record_post_action 18:46:34 INFO - ##### 18:46:34 INFO - ##### Running read-buildbot-config step. 18:46:34 INFO - ##### 18:46:34 INFO - Running pre-action listener: _resource_record_pre_action 18:46:34 INFO - Running main action method: read_buildbot_config 18:46:34 INFO - Using buildbot properties: 18:46:34 INFO - { 18:46:34 INFO - "project": "", 18:46:34 INFO - "product": "firefox", 18:46:34 INFO - "script_repo_revision": "production", 18:46:34 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 18:46:34 INFO - "repository": "", 18:46:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 18:46:34 INFO - "buildid": "20151221163010", 18:46:34 INFO - "pgo_build": "True", 18:46:34 INFO - "basedir": "/builds/slave/test-pgo", 18:46:34 INFO - "buildnumber": 260, 18:46:34 INFO - "slavename": "talos-linux64-ix-055", 18:46:34 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:46:34 INFO - "platform": "ubuntu64_hw", 18:46:34 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:46:34 INFO - "branch": "mozilla-inbound", 18:46:34 INFO - "repo_path": "integration/mozilla-inbound", 18:46:34 INFO - "revision": "ae5acd5505a0086aa9773649968cc969064819bc", 18:46:34 INFO - "stage_platform": "linux64-pgo", 18:46:34 INFO - "builduid": "791f1247ac2240de881ee7ee8d1c195a", 18:46:34 INFO - "slavebuilddir": "test" 18:46:34 INFO - } 18:46:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:46:34 INFO - Running post-action listener: _resource_record_post_action 18:46:34 INFO - ##### 18:46:34 INFO - ##### Running download-and-extract step. 18:46:34 INFO - ##### 18:46:34 INFO - Running pre-action listener: _resource_record_pre_action 18:46:34 INFO - Running main action method: download_and_extract 18:46:34 INFO - mkdir: /builds/slave/test-pgo/build/tests 18:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:34 INFO - https://queue.taskcluster.net/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:46:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/test_packages.json 18:46:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/test_packages.json 18:46:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 18:46:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 18:46:36 INFO - Downloaded 1302 bytes. 18:46:36 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 18:46:36 INFO - Using the following test package requirements: 18:46:36 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:46:36 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:46:36 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:36 INFO - u'jsshell-linux-x86_64.zip'], 18:46:36 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:46:36 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:46:36 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:46:36 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:46:36 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:46:36 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:46:36 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:46:36 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:46:36 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:36 INFO - https://queue.taskcluster.net/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:46:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:46:41 INFO - Downloaded 23175187 bytes. 18:46:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:46:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:46:42 INFO - Return code: 0 18:46:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:46:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:42 INFO - https://queue.taskcluster.net/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:46:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:46:47 INFO - Downloaded 23175187 bytes. 18:46:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 18:46:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:46:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:46:48 INFO - Return code: 0 18:46: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')]} 18:46:48 INFO - https://queue.taskcluster.net/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:46:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:46:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:46:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:46:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:46:49 INFO - Downloaded 11132277 bytes. 18:46:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 18:46:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:46:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:46:50 INFO - Return code: 0 18:46: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')]} 18:46:50 INFO - https://queue.taskcluster.net/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:46:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:46:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:46:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:46:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:46:51 INFO - Downloaded 54948278 bytes. 18:46:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:46:51 INFO - mkdir: /builds/slave/test-pgo/properties 18:46:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 18:46:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 18:46:51 INFO - Contents: 18:46:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:46:51 INFO - Running post-action listener: _resource_record_post_action 18:46:51 INFO - Running post-action listener: set_extra_try_arguments 18:46:51 INFO - ##### 18:46:51 INFO - ##### Running populate-webroot step. 18:46:51 INFO - ##### 18:46:51 INFO - Running pre-action listener: _resource_record_pre_action 18:46:51 INFO - Running main action method: populate_webroot 18:46:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:46:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:46:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:46:51 INFO - '--tppagecycles', 18:46:51 INFO - '7'], 18:46:51 INFO - 'tests': ['tsvgm']}}, 18:46:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:46:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:46:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:46:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:46:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:46:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:46:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:46:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:51 INFO - 'talos_options': ['--e10s'], 18:46:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:46:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:51 INFO - 'tests': ['damp', 'tps']}, 18:46:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:51 INFO - 'talos_options': ['--e10s'], 18:46:51 INFO - 'tests': ['damp', 'tps']}, 18:46:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:46:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:46:51 INFO - 'other': {'tests': ['a11yr', 18:46:51 INFO - 'ts_paint', 18:46:51 INFO - 'tpaint', 18:46:51 INFO - 'sessionrestore', 18:46:51 INFO - 'sessionrestore_no_auto_restore']}, 18:46:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:46:51 INFO - 'tests': ['a11yr', 18:46:51 INFO - 'ts_paint', 18:46:51 INFO - 'tpaint', 18:46:51 INFO - 'sessionrestore', 18:46:51 INFO - 'sessionrestore_no_auto_restore']}, 18:46:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:46:51 INFO - 'tests': ['a11yr', 18:46:51 INFO - 'ts_paint', 18:46:51 INFO - 'tpaint', 18:46:51 INFO - 'sessionrestore', 18:46:51 INFO - 'sessionrestore_no_auto_restore']}, 18:46:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:46:51 INFO - 'tests': ['a11yr', 18:46:51 INFO - 'ts_paint', 18:46:51 INFO - 'tpaint', 18:46:51 INFO - 'sessionrestore', 18:46:51 INFO - 'sessionrestore_no_auto_restore']}, 18:46:51 INFO - 'other_l64': {'tests': ['a11yr', 18:46:51 INFO - 'ts_paint', 18:46:51 INFO - 'tpaint', 18:46:51 INFO - 'sessionrestore', 18:46:51 INFO - 'sessionrestore_no_auto_restore']}, 18:46:51 INFO - 'other_nol64': {'tests': ['a11yr', 18:46:51 INFO - 'ts_paint', 18:46:51 INFO - 'tpaint', 18:46:51 INFO - 'sessionrestore', 18:46:51 INFO - 'sessionrestore_no_auto_restore']}, 18:46:51 INFO - 'svgr': {'tests': ['tsvgx', 18:46:51 INFO - 'tsvgr_opacity', 18:46:51 INFO - 'tart', 18:46:51 INFO - 'tscrollx', 18:46:51 INFO - 'cart']}, 18:46:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:46:51 INFO - 'tests': ['tsvgx', 18:46:51 INFO - 'tsvgr_opacity', 18:46:51 INFO - 'tart', 18:46:51 INFO - 'tscrollx', 18:46:51 INFO - 'cart']}, 18:46:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:51 INFO - 'tests': ['tp5o']}, 18:46:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:51 INFO - 'talos_options': ['--e10s'], 18:46:51 INFO - 'tests': ['tp5o']}, 18:46:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:51 INFO - 'talos_options': ['--xperf_path', 18:46:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:46:51 INFO - 'tests': ['tp5n']}, 18:46:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:46:51 INFO - 'talos_options': ['--e10s', 18:46:51 INFO - '--xperf_path', 18:46:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:46:51 INFO - 'tests': ['tp5n']}}, 18:46:51 INFO - 'talos.zip': {'path': '', 18:46:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:46:51 INFO - Running post-action listener: _resource_record_post_action 18:46:51 INFO - ##### 18:46:51 INFO - ##### Running create-virtualenv step. 18:46:51 INFO - ##### 18:46:51 INFO - Running pre-action listener: _resource_record_pre_action 18:46:51 INFO - Running main action method: create_virtualenv 18:46:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 18:46:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 18:46:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 18:46:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:46:51 INFO - Using real prefix '/usr' 18:46:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 18:46:52 INFO - Installing distribute.............................................................................................................................................................................................done. 18:46:54 INFO - Installing pip.................done. 18:46:54 INFO - Return code: 0 18:46:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 18:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:54 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 0x7f936bcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a7f0>, '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 0x1e962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e96760>, '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': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:46:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 18:46:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:46:54 INFO - Using env: {'DISPLAY': ':0', 18:46:54 INFO - 'HOME': '/home/cltbld', 18:46:54 INFO - 'LANG': 'en_US.UTF-8', 18:46:54 INFO - 'LANGUAGE': 'en_US:en', 18:46:54 INFO - 'LOGNAME': 'cltbld', 18:46:54 INFO - 'MAIL': '/var/mail/cltbld', 18:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:54 INFO - 'MOZ_NO_REMOTE': '1', 18:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:54 INFO - 'NO_EM_RESTART': '1', 18:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:54 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:54 INFO - 'SHELL': '/bin/bash', 18:46:54 INFO - 'SHLVL': '1', 18:46:54 INFO - 'TERM': 'linux', 18:46:54 INFO - 'TMOUT': '86400', 18:46:54 INFO - 'USER': 'cltbld', 18:46:54 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 18:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:54 INFO - '_': '/tools/buildbot/bin/python'} 18:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:54 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:46:54 INFO - Cleaning up... 18:46:54 INFO - Return code: 0 18:46:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 18:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:54 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 0x7f936bcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a7f0>, '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 0x1e962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e96760>, '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': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:46:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 18:46:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 18:46:54 INFO - Using env: {'DISPLAY': ':0', 18:46:54 INFO - 'HOME': '/home/cltbld', 18:46:54 INFO - 'LANG': 'en_US.UTF-8', 18:46:54 INFO - 'LANGUAGE': 'en_US:en', 18:46:54 INFO - 'LOGNAME': 'cltbld', 18:46:54 INFO - 'MAIL': '/var/mail/cltbld', 18:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:54 INFO - 'MOZ_NO_REMOTE': '1', 18:46:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:54 INFO - 'NO_EM_RESTART': '1', 18:46:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:54 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:54 INFO - 'SHELL': '/bin/bash', 18:46:54 INFO - 'SHLVL': '1', 18:46:54 INFO - 'TERM': 'linux', 18:46:54 INFO - 'TMOUT': '86400', 18:46:54 INFO - 'USER': 'cltbld', 18:46:54 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 18:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:54 INFO - '_': '/tools/buildbot/bin/python'} 18:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:54 INFO - Downloading/unpacking psutil>=0.7.1 18:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 18:46:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:46:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 18:46:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:46:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:46:56 INFO - Installing collected packages: psutil 18:46:56 INFO - Running setup.py install for psutil 18:46:56 INFO - building 'psutil._psutil_linux' extension 18:46:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:46:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:46:56 INFO - building 'psutil._psutil_posix' extension 18:46:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:46:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:46:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:46:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:46:56 INFO - Successfully installed psutil 18:46:56 INFO - Cleaning up... 18:46:56 INFO - Return code: 0 18:46:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 18:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:56 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 0x7f936bcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a7f0>, '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 0x1e962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e96760>, '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': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:46:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 18:46:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:46:56 INFO - Using env: {'DISPLAY': ':0', 18:46:56 INFO - 'HOME': '/home/cltbld', 18:46:56 INFO - 'LANG': 'en_US.UTF-8', 18:46:56 INFO - 'LANGUAGE': 'en_US:en', 18:46:56 INFO - 'LOGNAME': 'cltbld', 18:46:56 INFO - 'MAIL': '/var/mail/cltbld', 18:46:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:56 INFO - 'MOZ_NO_REMOTE': '1', 18:46:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:56 INFO - 'NO_EM_RESTART': '1', 18:46:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:56 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:56 INFO - 'SHELL': '/bin/bash', 18:46:56 INFO - 'SHLVL': '1', 18:46:56 INFO - 'TERM': 'linux', 18:46:56 INFO - 'TMOUT': '86400', 18:46:56 INFO - 'USER': 'cltbld', 18:46:56 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 18:46:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:56 INFO - '_': '/tools/buildbot/bin/python'} 18:46:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:46:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:46:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:46:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:46:58 INFO - Installing collected packages: mozsystemmonitor 18:46:58 INFO - Running setup.py install for mozsystemmonitor 18:46:58 INFO - Successfully installed mozsystemmonitor 18:46:58 INFO - Cleaning up... 18:46:58 INFO - Return code: 0 18:46:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 18:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:46:58 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 0x7f936bcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a7f0>, '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 0x1e962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e96760>, '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': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:46:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 18:46:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:46:58 INFO - Using env: {'DISPLAY': ':0', 18:46:58 INFO - 'HOME': '/home/cltbld', 18:46:58 INFO - 'LANG': 'en_US.UTF-8', 18:46:58 INFO - 'LANGUAGE': 'en_US:en', 18:46:58 INFO - 'LOGNAME': 'cltbld', 18:46:58 INFO - 'MAIL': '/var/mail/cltbld', 18:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:58 INFO - 'MOZ_NO_REMOTE': '1', 18:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:58 INFO - 'NO_EM_RESTART': '1', 18:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:46:58 INFO - 'PWD': '/builds/slave/test-pgo', 18:46:58 INFO - 'SHELL': '/bin/bash', 18:46:58 INFO - 'SHLVL': '1', 18:46:58 INFO - 'TERM': 'linux', 18:46:58 INFO - 'TMOUT': '86400', 18:46:58 INFO - 'USER': 'cltbld', 18:46:58 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 18:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:58 INFO - '_': '/tools/buildbot/bin/python'} 18:46:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:59 INFO - Downloading/unpacking blobuploader==1.2.4 18:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:46:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:00 INFO - Downloading blobuploader-1.2.4.tar.gz 18:47:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:47:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:47:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:47:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 18:47:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:01 INFO - Downloading docopt-0.6.1.tar.gz 18:47:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:47:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 18:47:01 INFO - Installing collected packages: blobuploader, requests, docopt 18:47:01 INFO - Running setup.py install for blobuploader 18:47:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:47:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 18:47:01 INFO - Running setup.py install for requests 18:47:01 INFO - Running setup.py install for docopt 18:47:02 INFO - Successfully installed blobuploader requests docopt 18:47:02 INFO - Cleaning up... 18:47:02 INFO - Return code: 0 18:47:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7f936bcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a7f0>, '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 0x1e962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e96760>, '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': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:47:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:02 INFO - Using env: {'DISPLAY': ':0', 18:47:02 INFO - 'HOME': '/home/cltbld', 18:47:02 INFO - 'LANG': 'en_US.UTF-8', 18:47:02 INFO - 'LANGUAGE': 'en_US:en', 18:47:02 INFO - 'LOGNAME': 'cltbld', 18:47:02 INFO - 'MAIL': '/var/mail/cltbld', 18:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:02 INFO - 'MOZ_NO_REMOTE': '1', 18:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:02 INFO - 'NO_EM_RESTART': '1', 18:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:02 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:02 INFO - 'SHELL': '/bin/bash', 18:47:02 INFO - 'SHLVL': '1', 18:47:02 INFO - 'TERM': 'linux', 18:47:02 INFO - 'TMOUT': '86400', 18:47:02 INFO - 'USER': 'cltbld', 18:47:02 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 18:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:02 INFO - '_': '/tools/buildbot/bin/python'} 18:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:02 INFO - Running setup.py (path:/tmp/pip-vnZF6I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:02 INFO - Running setup.py (path:/tmp/pip-fI7a5a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:02 INFO - Running setup.py (path:/tmp/pip-qA4ibD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:02 INFO - Running setup.py (path:/tmp/pip-cUBdn8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:02 INFO - Running setup.py (path:/tmp/pip-szKe5w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:02 INFO - Running setup.py (path:/tmp/pip-EZmdDT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:02 INFO - Running setup.py (path:/tmp/pip-clQkOl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:47:02 INFO - Running setup.py (path:/tmp/pip-t7zMKL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:47:02 INFO - Running setup.py (path:/tmp/pip-_Ug_W2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:47:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:47:02 INFO - Running setup.py (path:/tmp/pip-toT199-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:47:03 INFO - Running setup.py (path:/tmp/pip-nNlVni-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:47:03 INFO - Running setup.py (path:/tmp/pip-jcbTiQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:47:03 INFO - Running setup.py (path:/tmp/pip-QpB0Nr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:47:03 INFO - Running setup.py (path:/tmp/pip-5alyOh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:47:03 INFO - Running setup.py (path:/tmp/pip-tjbcF9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:47:03 INFO - Running setup.py (path:/tmp/pip-kgLllW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:47:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:47:03 INFO - Running setup.py (path:/tmp/pip-5U0yra-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:47:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:47:03 INFO - Running setup.py install for manifestparser 18:47:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 18:47:03 INFO - Running setup.py install for mozcrash 18:47:03 INFO - Running setup.py install for mozdebug 18:47:03 INFO - Running setup.py install for mozdevice 18:47:03 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 18:47:03 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 18:47:03 INFO - Running setup.py install for mozfile 18:47:04 INFO - Running setup.py install for mozhttpd 18:47:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 18:47:04 INFO - Running setup.py install for mozinfo 18:47:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 18:47:04 INFO - Running setup.py install for mozInstall 18:47:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 18:47:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 18:47:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 18:47:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 18:47:04 INFO - Running setup.py install for mozleak 18:47:04 INFO - Running setup.py install for mozlog 18:47:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 18:47:04 INFO - Running setup.py install for moznetwork 18:47:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 18:47:04 INFO - Running setup.py install for mozprocess 18:47:04 INFO - Running setup.py install for mozprofile 18:47:04 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 18:47:04 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 18:47:04 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 18:47:04 INFO - Running setup.py install for mozrunner 18:47:04 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 18:47:05 INFO - Running setup.py install for mozscreenshot 18:47:05 INFO - Running setup.py install for moztest 18:47:05 INFO - Running setup.py install for mozversion 18:47:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 18:47:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:47:05 INFO - Cleaning up... 18:47:05 INFO - Return code: 0 18:47:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:05 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 0x7f936bcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a7f0>, '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 0x1e962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e96760>, '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': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 18:47:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:05 INFO - Using env: {'DISPLAY': ':0', 18:47:05 INFO - 'HOME': '/home/cltbld', 18:47:05 INFO - 'LANG': 'en_US.UTF-8', 18:47:05 INFO - 'LANGUAGE': 'en_US:en', 18:47:05 INFO - 'LOGNAME': 'cltbld', 18:47:05 INFO - 'MAIL': '/var/mail/cltbld', 18:47:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:05 INFO - 'MOZ_NO_REMOTE': '1', 18:47:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:05 INFO - 'NO_EM_RESTART': '1', 18:47:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:05 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:05 INFO - 'SHELL': '/bin/bash', 18:47:05 INFO - 'SHLVL': '1', 18:47:05 INFO - 'TERM': 'linux', 18:47:05 INFO - 'TMOUT': '86400', 18:47:05 INFO - 'USER': 'cltbld', 18:47:05 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 18:47:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:05 INFO - '_': '/tools/buildbot/bin/python'} 18:47:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:05 INFO - Running setup.py (path:/tmp/pip-HEBrUy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 18:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 18:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:05 INFO - Running setup.py (path:/tmp/pip-alvENy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 18:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:05 INFO - Running setup.py (path:/tmp/pip-_dkioE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 18:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:05 INFO - Running setup.py (path:/tmp/pip-9LQ_DP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 18:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:05 INFO - Running setup.py (path:/tmp/pip-eObpmI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 18:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 18:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:05 INFO - Running setup.py (path:/tmp/pip-xvg9v3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 18:47:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 18:47:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:05 INFO - Running setup.py (path:/tmp/pip-u__cV1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 18:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:47:06 INFO - Running setup.py (path:/tmp/pip-mVEnaf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 18:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 18:47:06 INFO - Running setup.py (path:/tmp/pip-q6JRaU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 18:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 18:47:06 INFO - Running setup.py (path:/tmp/pip-Ijw27b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:47:06 INFO - Running setup.py (path:/tmp/pip-WKfcSl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 18:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:47:06 INFO - Running setup.py (path:/tmp/pip-3eHz78-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 18:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:47:06 INFO - Running setup.py (path:/tmp/pip-sgCs3t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 18:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:47:06 INFO - Running setup.py (path:/tmp/pip-TVTNa2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 18:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:47:06 INFO - Running setup.py (path:/tmp/pip-t2WlKv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 18:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 18:47:06 INFO - Running setup.py (path:/tmp/pip-td7WRO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 18:47:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 18:47:06 INFO - Running setup.py (path:/tmp/pip-ISPXCb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 18:47:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 18:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:08 INFO - Downloading blessings-1.5.1.tar.gz 18:47:08 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 18:47:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 18:47:08 INFO - Installing collected packages: blessings 18:47:08 INFO - Running setup.py install for blessings 18:47:08 INFO - Successfully installed blessings 18:47:08 INFO - Cleaning up... 18:47:08 INFO - Return code: 0 18:47:08 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 18:47:08 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:47:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:47:08 INFO - Reading from file tmpfile_stdout 18:47:08 INFO - Current package versions: 18:47:08 INFO - argparse == 1.2.1 18:47:08 INFO - blessings == 1.5.1 18:47:08 INFO - blobuploader == 1.2.4 18:47:08 INFO - docopt == 0.6.1 18:47:08 INFO - manifestparser == 1.1 18:47:08 INFO - mozInstall == 1.12 18:47:08 INFO - mozcrash == 0.16 18:47:08 INFO - mozdebug == 0.1 18:47:08 INFO - mozdevice == 0.47 18:47:08 INFO - mozfile == 1.2 18:47:08 INFO - mozhttpd == 0.7 18:47:08 INFO - mozinfo == 0.9 18:47:08 INFO - mozleak == 0.1 18:47:08 INFO - mozlog == 3.1 18:47:08 INFO - moznetwork == 0.27 18:47:08 INFO - mozprocess == 0.22 18:47:08 INFO - mozprofile == 0.28 18:47:08 INFO - mozrunner == 6.11 18:47:08 INFO - mozscreenshot == 0.1 18:47:08 INFO - mozsystemmonitor == 0.0 18:47:08 INFO - moztest == 0.7 18:47:08 INFO - mozversion == 1.4 18:47:08 INFO - psutil == 3.1.1 18:47:08 INFO - requests == 1.2.3 18:47:08 INFO - wsgiref == 0.1.2 18:47:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 18:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:08 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 0x7f936bcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a7f0>, '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 0x1e962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e96760>, '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': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 18:47:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:47:08 INFO - Using env: {'DISPLAY': ':0', 18:47:08 INFO - 'HOME': '/home/cltbld', 18:47:08 INFO - 'LANG': 'en_US.UTF-8', 18:47:08 INFO - 'LANGUAGE': 'en_US:en', 18:47:08 INFO - 'LOGNAME': 'cltbld', 18:47:08 INFO - 'MAIL': '/var/mail/cltbld', 18:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:08 INFO - 'MOZ_NO_REMOTE': '1', 18:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:08 INFO - 'NO_EM_RESTART': '1', 18:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:08 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:08 INFO - 'SHELL': '/bin/bash', 18:47:08 INFO - 'SHLVL': '1', 18:47:08 INFO - 'TERM': 'linux', 18:47:08 INFO - 'TMOUT': '86400', 18:47:08 INFO - 'USER': 'cltbld', 18:47:08 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 18:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:08 INFO - '_': '/tools/buildbot/bin/python'} 18:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 18:47:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 18:47:09 INFO - Cleaning up... 18:47:09 INFO - Return code: 0 18:47:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 18:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:09 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 0x7f936bcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a7f0>, '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 0x1e962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e96760>, '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': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 18:47:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:47:09 INFO - Using env: {'DISPLAY': ':0', 18:47:09 INFO - 'HOME': '/home/cltbld', 18:47:09 INFO - 'LANG': 'en_US.UTF-8', 18:47:09 INFO - 'LANGUAGE': 'en_US:en', 18:47:09 INFO - 'LOGNAME': 'cltbld', 18:47:09 INFO - 'MAIL': '/var/mail/cltbld', 18:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:09 INFO - 'MOZ_NO_REMOTE': '1', 18:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:09 INFO - 'NO_EM_RESTART': '1', 18:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:09 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:09 INFO - 'SHELL': '/bin/bash', 18:47:09 INFO - 'SHLVL': '1', 18:47:09 INFO - 'TERM': 'linux', 18:47:09 INFO - 'TMOUT': '86400', 18:47:09 INFO - 'USER': 'cltbld', 18:47:09 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 18:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:09 INFO - '_': '/tools/buildbot/bin/python'} 18:47:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:09 INFO - Downloading/unpacking jsonschema 18:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:47:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 18:47:11 INFO - Downloading/unpacking functools32 (from jsonschema) 18:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:11 INFO - Downloading functools32-3.2.3-2.tar.gz 18:47:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 18:47:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 18:47:11 INFO - warning: no files found matching '*.txt' 18:47:11 INFO - no previously-included directories found matching 'build' 18:47:11 INFO - no previously-included directories found matching 'dist' 18:47:11 INFO - no previously-included directories found matching '.git*' 18:47:11 INFO - Installing collected packages: jsonschema, functools32 18:47:11 INFO - Running setup.py install for functools32 18:47:11 INFO - warning: no files found matching '*.txt' 18:47:11 INFO - no previously-included directories found matching 'build' 18:47:11 INFO - no previously-included directories found matching 'dist' 18:47:11 INFO - no previously-included directories found matching '.git*' 18:47:11 INFO - Successfully installed jsonschema functools32 18:47:11 INFO - Cleaning up... 18:47:11 INFO - Return code: 0 18:47:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 18:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:47:11 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 0x7f936bcf1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e98230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a7f0>, '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 0x1e962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e96760>, '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': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:47:11 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 18:47:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 18:47:11 INFO - Using env: {'DISPLAY': ':0', 18:47:11 INFO - 'HOME': '/home/cltbld', 18:47:11 INFO - 'LANG': 'en_US.UTF-8', 18:47:11 INFO - 'LANGUAGE': 'en_US:en', 18:47:11 INFO - 'LOGNAME': 'cltbld', 18:47:11 INFO - 'MAIL': '/var/mail/cltbld', 18:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:11 INFO - 'MOZ_NO_REMOTE': '1', 18:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:11 INFO - 'NO_EM_RESTART': '1', 18:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:11 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:11 INFO - 'SHELL': '/bin/bash', 18:47:11 INFO - 'SHLVL': '1', 18:47:11 INFO - 'TERM': 'linux', 18:47:11 INFO - 'TMOUT': '86400', 18:47:11 INFO - 'USER': 'cltbld', 18:47:11 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 18:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:11 INFO - '_': '/tools/buildbot/bin/python'} 18:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:47:11 INFO - Downloading/unpacking flake8 18:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:47:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 18:47:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:47:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 18:47:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 18:47:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:47:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:47:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:47:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 18:47:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 18:47:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:47:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:47:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:47:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:47:14 INFO - no previously-included directories found matching 'docs/_build' 18:47:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:47:14 INFO - Running setup.py install for pep8 18:47:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:47:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:47:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:47:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:47:14 INFO - no previously-included directories found matching 'docs/_build' 18:47:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 18:47:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:47:14 INFO - Cleaning up... 18:47:14 INFO - Return code: 0 18:47:14 INFO - Running post-action listener: _resource_record_post_action 18:47:14 INFO - Running post-action listener: _start_resource_monitoring 18:47:14 INFO - Starting resource monitoring. 18:47:14 INFO - ##### 18:47:14 INFO - ##### Running install step. 18:47:14 INFO - ##### 18:47:14 INFO - Running pre-action listener: _resource_record_pre_action 18:47:14 INFO - Running main action method: install 18:47:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 18:47:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 18:47:14 INFO - Reading from file tmpfile_stdout 18:47:14 INFO - Detecting whether we're running mozinstall >=1.0... 18:47:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 18:47:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 18:47:14 INFO - Reading from file tmpfile_stdout 18:47:14 INFO - Output received: 18:47:14 INFO - Usage: mozinstall [options] installer 18:47:14 INFO - Options: 18:47:14 INFO - -h, --help show this help message and exit 18:47:14 INFO - -d DEST, --destination=DEST 18:47:14 INFO - Directory to install application into. [default: 18:47:14 INFO - "/builds/slave/test-pgo"] 18:47:14 INFO - --app=APP Application being installed. [default: firefox] 18:47:14 INFO - mkdir: /builds/slave/test-pgo/build/application 18:47:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 18:47:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 18:47:30 INFO - Reading from file tmpfile_stdout 18:47:30 INFO - Output received: 18:47:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 18:47:30 INFO - Running post-action listener: _resource_record_post_action 18:47:30 INFO - ##### 18:47:30 INFO - ##### Running run-tests step. 18:47:30 INFO - ##### 18:47:30 INFO - Running pre-action listener: _resource_record_pre_action 18:47:30 INFO - Running main action method: run_tests 18:47:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 18:47:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 18:47:30 INFO - Python 2.7.3 18:47:30 INFO - Return code: 0 18:47:30 INFO - grabbing minidump binary from tooltool 18:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:47:30 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 0x1f2a7f0>, '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 0x1e962d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e96760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 18:47:30 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 18:47:30 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:47:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:47:30 INFO - Return code: 0 18:47:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 18:47:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 18:47:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 18:47:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 18:47:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 18:47:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 18:47:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 18:47:31 INFO - Return code: 0 18:47:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 18:47:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:47:31 INFO - Using env: {'DISPLAY': ':0', 18:47:31 INFO - 'HOME': '/home/cltbld', 18:47:31 INFO - 'LANG': 'en_US.UTF-8', 18:47:31 INFO - 'LANGUAGE': 'en_US:en', 18:47:31 INFO - 'LOGNAME': 'cltbld', 18:47:31 INFO - 'MAIL': '/var/mail/cltbld', 18:47:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:47:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 18:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:47:31 INFO - 'MOZ_NO_REMOTE': '1', 18:47:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 18:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:47:31 INFO - 'NO_EM_RESTART': '1', 18:47:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 18:47:31 INFO - 'PWD': '/builds/slave/test-pgo', 18:47:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 18:47:31 INFO - 'SHELL': '/bin/bash', 18:47:31 INFO - 'SHLVL': '1', 18:47:31 INFO - 'TERM': 'linux', 18:47:31 INFO - 'TMOUT': '86400', 18:47:31 INFO - 'USER': 'cltbld', 18:47:31 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991', 18:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:47:31 INFO - '_': '/tools/buildbot/bin/python'} 18:47:31 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:47:31 INFO - mozversion application_buildid: 20151221163010 18:47:31 INFO - mozversion application_changeset: ae5acd5505a0086aa9773649968cc969064819bc 18:47:31 INFO - mozversion application_display_name: Nightly 18:47:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:47:31 INFO - mozversion application_name: Firefox 18:47:31 INFO - mozversion application_remotingname: firefox 18:47:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:47:31 INFO - mozversion application_vendor: Mozilla 18:47:31 INFO - mozversion application_version: 46.0a1 18:47:31 INFO - mozversion platform_buildid: 20151221163010 18:47:31 INFO - mozversion platform_changeset: ae5acd5505a0086aa9773649968cc969064819bc 18:47:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:47:31 INFO - mozversion platform_version: 46.0a1 18:47:31 INFO - using testdate: 1450752451 18:47:31 INFO - actual date: 1450752451 18:47:31 INFO - starting webserver on 'localhost:39164' 18:47:31 INFO - SUITE-START | Running 3 tests 18:47:31 INFO - TEST-START | dromaeo_css 18:47:31 INFO - operating with platform_type : linux_ 18:47:31 INFO - Initialising browser for dromaeo_css test... 18:47:31 INFO - TEST-INFO | started process 14028 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMrd2vW/profile http://localhost:39164/getInfo.html) 18:47:35 INFO - PROCESS | 14028 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 18:47:36 INFO - PROCESS | 14028 | __metrics Screen width/height:1600/1200 18:47:36 INFO - PROCESS | 14028 | colorDepth:24 18:47:36 INFO - PROCESS | 14028 | Browser inner width/height: 1024/697 18:47:36 INFO - PROCESS | 14028 | __metrics 18:47:36 INFO - PROCESS | 14028 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 18:47:37 INFO - TEST-INFO | 14028: exit 0 18:47:37 INFO - Browser initialized. 18:47:37 INFO - Running cycle 1/1 for dromaeo_css test... 18:47:37 INFO - TEST-INFO | started process 14158 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMrd2vW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:47:48 INFO - PROCESS | 14158 | RSS: Main: 150761472 18:47:48 INFO - PROCESS | 14158 | 18:48:38 INFO - PROCESS | 14158 | 1450752518531 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:50:47 INFO - PROCESS | 14158 | Cycle 1(1): loaded http://localhost:39164/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39164/tests/dromaeo/cssquery-ext.html) 18:50:48 INFO - PROCESS | 14158 | RSS: Main: 156848128 18:50:48 INFO - PROCESS | 14158 | 18:53:50 INFO - PROCESS | 14158 | Cycle 1(1): loaded http://localhost:39164/tests/dromaeo/cssquery-ext.html (next: http://localhost:39164/tests/dromaeo/cssquery-jquery.html) 18:53:51 INFO - PROCESS | 14158 | RSS: Main: 153485312 18:53:51 INFO - PROCESS | 14158 | 18:56:52 INFO - PROCESS | 14158 | Cycle 1(1): loaded http://localhost:39164/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39164/tests/dromaeo/cssquery-mootools.html) 18:56:53 INFO - PROCESS | 14158 | RSS: Main: 153305088 18:56:53 INFO - PROCESS | 14158 | 18:59:55 INFO - PROCESS | 14158 | Cycle 1(1): loaded http://localhost:39164/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39164/tests/dromaeo/cssquery-prototype.html) 18:59:55 INFO - PROCESS | 14158 | RSS: Main: 152174592 18:59:55 INFO - PROCESS | 14158 | 19:02:58 INFO - PROCESS | 14158 | Cycle 1(1): loaded http://localhost:39164/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39164/tests/dromaeo/cssquery-yui.html) 19:02:58 INFO - PROCESS | 14158 | RSS: Main: 152350720 19:02:58 INFO - PROCESS | 14158 | 19:06:01 INFO - PROCESS | 14158 | Cycle 1(1): loaded http://localhost:39164/tests/dromaeo/cssquery-yui.html (next: http://localhost:39164/tests/dromaeo/cssquery-dojo.html) 19:06:01 INFO - PROCESS | 14158 | RSS: Main: 155189248 19:06:01 INFO - PROCESS | 14158 | 19:06:01 INFO - PROCESS | 14158 | __start_tp_report 19:06:01 INFO - PROCESS | 14158 | _x_x_mozilla_page_load 19:06:01 INFO - PROCESS | 14158 | _x_x_mozilla_page_load_details 19:06:01 INFO - PROCESS | 14158 | |i|pagename|runs| 19:06:01 INFO - PROCESS | 14158 | |0;dojo.html;3162.7153556179946;3188.728958038567;3215.4372984727665;3222.13002489328;3236.5145228215765;5354.9196762048605;5380.757865896035;5384.91922621161;5400.567954563635;5403.594730395222;5392.056390131721;5402.162664786964;5434.239206511082;5440.945590544094;5464.781408743645;5002.374703162114;5008.173651347523;5055.9747201263945;5087.84736457905;5163.277141200235;5141.76862041209;5170.6122040847085;5204.869878253036;5224.346956630421;5229.8954020919555;4908.239222920453;4935.432425271104;4959.057779021974;4984.87537811554;5053.0399224147295;4971.27916452116;4972.0801651694555;4978.676386034932;4991.326170966946;5004.474530174352;4944.035912996967;4959.479254678243;4974.030064137494;4975.925361119586;5019.824306149304;5194.194899790538;5232.790688372498;5296.655717378358;5308.893822123536;5309.41596424393;5852.239208902815;5860.208871802337;5871.911921321183;5877.764889404419;5898.085796701475;5890.293164820207;5897.3218079920925;5903.321118071433;5912.965231084543;5952.107183922403;5493.615446918718;5590.608657393984;5597.300337457858;5613.663180209201;5640.943590564124;5941.881162376815;5991.580589358703;5991.9700401498585;5996.550258730613;6000.909986350208;5764.5676574257095;5783.248177736951;5800.129980502874;5823.272090988627;5881.970590147107;5929;5963.135345374896;5974.462298393166;5983.6708981005595;6023.156758053876;5828.708564571754;5872.911906321408;5893.705314734246;5894.2926848778425;5915.497182739516;5675.659460432387;5757.395473475309;5838.591298609142;5885.764569417175;5937.050071988461;4542.205114105084;4553.658475614276;4563.361129441881;4583.243764778841;4593.793279302439;4033.6369726724733;4049.959500405017;4051.2505186539993;4057.0668746188544;4090;5421.891562168814;5516.586256030733;5552.444755524496;5632.5212356950115;5657.32112146545;5904.852378690567;5944;5963.850903727442;5989.730462129215;5992.310884248367;5536.058869992111;5569.749361278752;5578.023845826964;5591.27313449249;5611.709306859445;5046.39443266803;5123.2827404163445;5126.256692779526;5127.897442051138;5138.794448222029;5973.492253158443;6021.548383871227;6025.578209525379;6047.334793172748;6069.119977603223;5905.557083218861;5966.731497082555;5997.190379298913;6007.30915944672;6041.969790151021;5853.824385268449;5938.376470470711;5966.403359663999;6073.331933487401;6081.118237855575;5835.44563266489;5863.442972917566;5866.413358664099;5873.353931067664;5923.141144534105;5893.116032595145;5931.792387266425;5947.31605865331;5950.256217972754;5959.1657167995645;5628.0432326505415;5660.094384898561;5775.971120144372;5781.132830075354;5791.420857914343;5786.42135786418;5788.710564471844;5798.072308430631;5802.564807639359;5805.245318108788;5641.294838145232;5677.3754886963225;5688.971555142198;5718.1708652246025;5728.312602487728;5637.605367624227;5715.714214289185;5748.39641837601;5793.391693872083;5847.970760146172;5658.434156584473;5660.943390566042;5665.745041473061;5696.458836410535;5709.65742055478 19:06:01 INFO - PROCESS | 14158 | |1;ext.html;560.5179545590792;591.5060924128355;597.4115496236204;600.1807532717842;600.9849753756156;36564.45153322699;36699;37092.81453592735;37213.255734885286;37301;41285;41475.377869331984;41520;41715.79142104293;41749;8556.999999999984;8589.35579831512;8663.350248731338;8679.349048821332;8704.608292626815;8485.406021578492;8538.06081331053;8579.399442039059;8604.139586041409;8627.913720862805;8589.184027517376;8670.13298670131;8671.69649062283;8676.436031657922;8697.652093916236;8512.1487851215;8524.488530688179;8532.976042874832;8563.357748168912;8579.914200857975;8471.661133554651;8595.18345757152;8602.35482338827;8623.439476434012;8625.956870215608;38783;39213;39239.21521569581;39249.21501569953;39379.8031009846;2934.7212014858555;2938.6620538638117;3049.329147587527;3243.065026151337;3268.346330733863;29470.115896523137;29972.550411743625;30126.24684382886;30201;30438.391232175232;3768.660820526166;3862;3883.126296583246;3919.647231749128;3931.842726290945;248680;249834;250133.749331254;250369;251285;43968.16350201475;44732.55267447349;53570.73214633902;53829.73085134549;53836.73081634567;62829.68585157045;63757.36242637607;64189.35810641927;64275.678621606596;64332;14583.125012499284;14818.259087045604;14831.480898168513;14835.332410041574;14840.332185051699;10938.289011214405;10963.56145754161;10966.780664386668;10969.670909872717;10972.561097556169;18356.173972171284;18615.627687446446;18695.626087478173;18699.439016829518;18703.81296187048;7562.395008399315;7782.49413788102;7824.217578242244;7869.842603147905;7889.8816517752275;888.7333799860016;898.4878619187001;909.1454033208763;915.8809354783969;1071.5553045486192;25064.624030639556;25257;25275.11537096193;25371.619425708628;25415.093867959607;977.154761131616;1015.2487159501916;1026.1021606094666;1107.8725946516092;1119.8152304869604;14859.554213373616;15594.532164035098;15620.140892251035;15875;15883.602909927113;346290;349847;352680;353033;353543;52714.47285527172;52777;53325;53518.73240633772;53663.73168134134;1339.6182088104842;1362.1146254934174;1370.520317888731;1374.2647683489286;1376.6764810269779;29056.85471572713;30543.694563054974;30922.53616195804;32486.512702309956;32657.2350459171;48169;48784.75607621939;48883;48945;48961.51038489569;284235.1576484209;286362;286857;287435;287714;41219;44861;44917.550824491336;45277.773611131735;45592.77203614094;41891;42004.78997604993;42114.36828447637;42539.36190957076;42728.35907461453;33263.439660940756;35436.64563354333;35833.520585225204;36017.09957250985;36139.638603613625;36150;36541.45187822238;36795.63204368029;37447.81276093602;41014.38478422767;33593.66406335905;37518.43722344113;38022.42966355452;38047.239055219296;38093.71437713746;29687.85156074206;32668;33132.503012455316;33170.83414582912;33206;25118.74881251164;25128;25278.620820688073;25474.87262563675;25802.48395032051 19:06:01 INFO - PROCESS | 14158 | |2;jquery.html;349.4478723616686;357.6298531020393;361.3513742831617;363.4167161705463;369.49563845351094;13905.79141312881;14202.71594568108;15741.449049283277;16268.755968660465;16675.249613767395;15962.281697323619;16391.4263000795;16587.585310367216;16628.83371166288;16670.58323541912;4767.356406885069;4942;4951.826686065989;4951.851444456672;4955.826546070888;4895.975520122394;4960.429550601691;5266.736663166846;5372.57019438446;5397.920415916813;5334.173203153498;5348.251244825728;5350.973245133769;5377.542908852753;5394.487523685263;5363.275957745694;5993.160957465958;6025.487833534155;6032.034874420094;6036.094585812098;5342.759575819097;5356.758945847446;5357.142857142839;5374.032674118657;5390.272313237702;18491;20316.69524957127;20837.479063023395;21082;21234.256801012045;2044.570640165567;2051.9487012824798;2056.3728062940795;2064.607724532334;2106.2101711858054;9748.122668959757;9767.51162441875;9843.60625574976;9961.800763984753;9976.152027077707;1771.7430972509044;1775.2632657447143;1804.4316040447218;1840.7146892231726;1841.917113729872;58428;62382.37617623811;62688;62978;63448;10330.948345258375;10434.478276086165;10473.319234249902;10482.056614904695;10502.369857808557;13599.388027538784;13614.115082519604;13618.18290902549;13626.591202263948;13672.31638418075;7259.963700181571;7422.257774222642;7458.2541745826065;7483.925160748432;7490.5131166474;7402.814929626802;7430.962845185848;7475.168583697029;7476.25237476248;7486.251374862471;4092.3656833190903;4146.440230568895;4216.198922204771;4231.978840105779;4249.107687385684;1821.8633602479601;1833.2575307000686;1847.4550007747746;1871.2421469304954;1872.597391560821;853.5092321914924;859.7807559072396;895.6730793260543;999.81003609314;1034.591336422109;15952.680946381008;16835.831641683428;16914.407995720092;17098.401555945482;17210.91394543019;880.7269746378643;898.167856929727;908.63704443335;935.9204467620192;999.695092996643;9702.563384647709;9758.512074396253;10249.436281004468;10258.487075646188;10316.277860549839;502107;502694.2709869629;514872;523619;530540;82992.17007829844;83860;84558;85244;86120.13879861121;1090.8854570270166;1091.24158709696;1105.452366686645;1111.7109551516664;1112.1547623805966;15892.12593307333;15900.68198636044;16224;16261.918690406472;16370;36014.4597831038;36466;36598.451023235204;37123.44314835226;38334.6166538331;48684.75657621689;49497.50502495073;50156;51571.484285156665;52171.47828521666;9598.136167744937;9829.754256143653;9831.164351030242;9847.064528869745;9864.802703946025;12890.29103399322;16507.33970641161;16746.581335466224;16752.74870876962;17305.56736081608;9477.810443790948;9743.366681165986;9772.755681108029;15240.314185861442;15377.76933346023;9616.134547890724;9957.800843983225;9973.202143828332;10057.094861462503;10239.7440063999;9370.906290937004;9463.763405914908;9468.857967130636;9551.235901128031;9863.358881672955;14811.185384803939;14837.851621484078;14957.102573845605;14967.326470308644;15306.23468826532;13878.653033674238;14101;14270.785938210727;14432.42270309176;14534.781978270123 19:06:01 INFO - PROCESS | 14158 | |3;mootools.html;1327.674719693675;1338.27733024167;1473.6242258224158;1796.0570700382307;1804.6390721855632;6948.617826019567;7043.929560704391;7445;7850.332721718646;7872.33085187759;7505.549667019983;7740.458167928247;7767.572783496906;7817.804554886116;7825.765227043198;2264.954700905985;2278.4190031541934;2279.7492275849645;2285.0745448093467;2291.3927809130596;2289.9084036638515;2294.19703103914;2341.8009469195053;2355.611324131516;2361.0319768894756;2313.9190128345513;2321.0483701682315;2342.5549145662353;2365.7161140663143;2370.1822871109525;2282.9543409131725;2307.342407413879;2311.17953126641;2315.525317309956;2319.7680231976838;2305.4005958450757;2333.5916214662366;2335.007621760762;2335.2994101769573;2337.1703045418803;7655.655495502716;7681.692732290701;7699;7720.575368354738;7785.065792104927;4753.738544380058;4824.445188803263;4842.297866809328;4857.1742803723455;4863;3145.5596216529702;3149.0161198444835;3209.983950080258;3216.839158042112;3237.14215732831;1019.8322920256265;1037.553851843707;1046.638909576195;1049.9972526237425;1083.063150374928;10813.83779243312;10851.837222441669;10932.180086493545;10942.945285273523;10957.342559446459;4282.35764635301;4319.373690814814;4375.212461756914;4394.209042372339;4398.164348773723;9385.765355866022;9408.858867116998;9433.952830235805;9440.527973601429;9449.102335278138;4824.614030877521;4827.541383568555;4833.492483289274;4841.104395686739;4857.951420485821;3778.263238668488;3867.690584753213;4310.633596144363;4380.737155770664;4388.232059389594;3686.852525898934;3698.537682789651;3701.722370822199;3717.386631205875;3725.273571653556;1159.5419809175496;1162.0703437250336;1172.5427083437467;1174.1487421619258;1191.0352614382377;947.966821161256;962.6967505235829;964.5514835601479;1035.409816404642;1289.9935500322438;7325.560466372035;7329.340359367682;7355.668994895243;7366.410687145016;7383.372413344819;470.3720533088297;473.15305602970983;474.36198313268596;475.9262314341283;478.7271255384467;5474;5483.479069488392;5524.751386187631;5527.53015993637;5536.667799932017;9218.769530761785;9322.627094916128;9462.29032822541;9638.518074096268;9701.272404569685;9449.716508504756;9452;9473.526323683789;9511.286653501014;9555.23558115349;7151.177614574391;7193.4604904631315;7211.423086153095;7307.5980821055355;7333.339999399973;6972.442204623517;7010.334018268256;7010.614416207158;7026.1217347831525;7027.402670773042;8251.29863961546;8406.747797566082;8478.788030299045;8601.784955376166;8642.870356944524;8579.914200858162;8625.964884213934;8633.784155396166;8697.304215662858;8754.21212090915;6005.099235114768;6432.742690292336;6677.632730199885;6836.38472537474;6908.378245957888;7655.46411751172;7678.500897441649;7680.80797980055;7726.690932362642;7751.3411360035025;7001.8249543759775;7136.3934065602925;7182.533135346186;7225.819354515969;7300.525465844703;7109.573425594274;7114.608696521741;7153.463490238357;7213.422926165789;7245.746398876014;6573.244076931214;6685.933140668531;6734.9326506734305;6743.763968261087;6764;6142.754289828536;6180.196574445294;6180.721867515883;6198.163247961648;6220.066989951543;6219.191505104308;6241.375862413723;6243.063540468966;6303.495720342454;6363.490920726238 19:06:01 INFO - PROCESS | 14158 | |4;prototype.html;324.4840703281782;325.9315543735814;335.9714424273937;342.08833458832214;350.2329897524421;6337.619742815428;6358.936410635893;6379.489640828734;6390.680465976706;6473.4821214302865;6356.3008069112475;6381.840453988652;6392.968035159829;6403.231612206541;6403.263624683163;4853.053654537367;4858;4858.78135483904;4863.781129849148;4874.220124780027;4854.101991131634;4861.295112208728;4868.56182943535;4881;4888.535589119028;4635.258358662614;4645.86062418128;4726.929096063562;4759.524047595248;4795.23276275796;4736.668433209677;4742.454617718955;4746.810127594892;4749.928751068736;4757.833475828364;4109.198706252282;4123.989622542466;4126.587341265879;4128.174365126986;4141.130362623852;5967.731452084667;5981.37195594465;5993.670348130851;5994.100884867261;5997.22036135304;5481.671099734029;5550.58370622205;5563.527100196488;5573.136163894603;5576.609637325389;6650.7339706411685;6669.599824010575;6674.833129171761;6681.498887583402;6687.732490700366;4549.522300158469;4556.498785133633;4572.199865023641;4589.839355622537;4604.539546045402;6793.898091528631;6896.413804826546;6904.13698287714;6963.373296403348;6995.580265184105;4681.321208424827;4684.320773487893;4685.390899183084;4691.788869500812;4696.131215725101;4716.245400735866;4738.857834264978;4740.1230772307235;4748;4759.048190361941;5527.060399732055;5528.944710552843;5528.9723551381985;5535.335759708861;5541.833744987657;6620.437262832713;6738.629375384401;6752.527323087336;6764.526483146133;6773.322667733188;1648.5878530367409;1677.488366048367;1679.7984241891052;1682.9747553786704;1686.3844696685867;1111.5498223219608;1111.8665760108838;1112.3826276416667;1125.2573301620891;1132.818749000156;6412.935870641327;6417.7753778617525;6424.871502570016;6427.839304017343;6433.453156481658;6956.478264130211;6990.09128813251;7009.684564194624;7013.754518591825;7016.859662806817;6298.149749783812;6426.742930282736;6433.292337842833;6493.25327587324;6519.478441724651;3831.099691572478;3842.212346468967;3854.9807250963568;3861.4593956846065;3866.130120722815;7209.062821833233;7215.2582018833555;7218.60297683622;7220.711171553079;7229.060222171084;7116.146062472537;7219.45854060937;7270.527415717961;7295.744648937261;7315.30504602062;7140.178879428829;7172.462065345016;7187.9281207188305;7188.892166617505;7210.567365957954;7047.436205103477;7051.43588512928;7069.328413800681;7079.929200707927;7103.680334385069;6797.524173307821;7011.3339232772805;7015.36861682451;7021.438284937295;7021.894671579828;7191.316824901626;7209.567425954459;7210.603416812126;7215.314545118205;7215.494915355875;4706.835260765857;4751.358566593604;4758.191107511662;4761.785719642555;4763.880902977453;6896.724131034703;7053.118360204974;7127.8574428512175;7133.928660713326;7140.178879428932;6811.4550835934;6834;6837.794866154023;6883.139607549057;6896.7586134485055;6725.327467253235;6881.346272104142;6888.104546408935;6893.551919125241;6904.13698287714;6743.9325606743305;6747.561408508432;6753.2909044549615;6754.797356079325;6757.932420675927;6851.725930962705;6859.451243900576;6906.93093069083;6907.240203577703;6915.204751453647;6515.73937042532;6674.699638516181;6715.7985260442265;6736.124303840666;6740.831479213059 19:06:01 INFO - PROCESS | 14158 | |5;yui.html;663.8103910709044;681.131557264488;748.6892939430137;776.3982913242237;779.0573406178523;13621.523246686367;13870.445182192725;13924.582262532114;13968.511102111428;13983.86016139837;13042.60872173834;13243.205407675547;13246.47014119434;13312.800307995363;13384.130031547942;784.1022029775918;786.2844811221789;796.1640277708412;796.8246985663145;797.0873350014231;785.132428666324;789.1398375770409;789.7393860026207;790.7864876483346;796.5181065455403;815.6451943404609;820.1962077164383;824.2499325613693;824.6124321568883;827.8468483330573;818.5907046476761;819.1071731812353;820.8358328334327;821.5399376349263;823.2014945502852;605.5216379060581;605.9303180134297;606.2694453183902;607.4077774170192;607.7903123422412;13634.863651363557;13680.247586382746;13684.452621895112;13691.178529288274;13782.793258101137;10805;11080.445977701163;11401.48693308803;11469.483873225641;12951.546695865694;10091.344062635904;10123.341982771097;10222.6422075227;10378.221633377527;10630.893691063067;3528.8059156746367;3545.840437180333;3584.4981702561663;3599.406097993828;3612.7832330060282;45011.77494112541;49987.75006124946;50499.747501262624;50698.23952640713;50789.746051269874;8854.824255207472;9431.292653050912;9533.285003624756;9811.31320807551;10134;17382.913085434746;17404.825951740575;17409.825901741075;17476.737848932276;17482.912585437247;6980.93019069813;7159.140903091662;7212.603306818175;7312.268773122752;7434.888476672854;3856.7685938843197;3885.980570097188;3899.922001559953;3939.2121575684405;4026.315526360526;3109.207152176226;3135.1064946490596;3136.8274744888795;3138.0272115644225;3144.9371012579622;566.3458705195424;571.0606053042721;583.5973178506816;584.0509172594534;585.4672248254153;475.65990316923563;492.3992728870772;534.6444614331426;544.9700066873612;565.926429564154;7523;7551.773446796605;7572.697092116364;7624.656890439944;7686.730964416219;457.5127489224032;493.73091665042637;507.2821956930975;574.1789241384777;623.3610549187028;3551.6803487685715;3569.161247106928;3597.874074407383;3611.8735844245325;3659.835307411173;54099;54409.72795136078;54410.45589544054;54470.45529544733;55084.72457637767;47025;47315.76342118267;47405.5259447408;47759.761201194466;47762;42422;43404.34893476601;44429.777851110535;44673;45002.32496512555;7093.3970612498515;7198.820029499095;7574.580020326234;7691.538507689556;7765.145833958373;31067.689323107385;31919.042428727174;32771.50842737313;34484.82757586196;36300.63699362973;42999;43976.78011609922;44293.55706442894;44982.325265121704;45176.77411612921;10612.575496980035;10663.626773063215;10693.411862347646;11031.83452248233;11263.605773797877;11023.559057637605;11071;11309.830352544883;11370.54517819278;11569.421528923353;9437.905620943977;9479.573419196015;9599.328047036919;9615.9038409615;9700.078492543196;9379.484128373006;9790.510474476105;9799.657012004545;9881.851772223567;9931.997941451114;9348.345615806827;9498.810023799348;9517.381370210915;9525.666601668909;9694.854577181206;8509.191626795444;8711.172438618321;8720.171583699539;8783.121687831166;9050.094990500897;7989.52062876206;8315.04376996653;8385.706500272461;8388.580570971304;8396.496210227406 19:06:01 INFO - PROCESS | 14158 | __end_tp_report 19:06:01 INFO - PROCESS | 14158 | __start_cc_report 19:06:01 INFO - PROCESS | 14158 | _x_x_mozilla_cycle_collect,293 19:06:01 INFO - PROCESS | 14158 | __end_cc_report 19:06:01 INFO - PROCESS | 14158 | __startTimestamp1450753561342__endTimestamp 19:06:01 INFO - PROCESS | 14158 | 19:06:01 INFO - PROCESS | 14158 | ------- Summary: start ------- 19:06:01 INFO - PROCESS | 14158 | Number of tests: 6 19:06:01 INFO - PROCESS | 14158 | 19:06:01 INFO - PROCESS | 14158 | [#0] dojo.html Cycles:165 Average:5472.18 Median:5675.66 stddev:611.63 (10.8%) stddev-sans-first:586.06 19:06:01 INFO - PROCESS | 14158 | Values: 3162.7 3188.7 3215.4 3222.1 3236.5 5354.9 5380.8 5384.9 5400.6 5403.6 5392.1 5402.2 5434.2 5440.9 5464.8 5002.4 5008.2 5056.0 5087.8 5163.3 5141.8 5170.6 5204.9 5224.3 5229.9 4908.2 4935.4 4959.1 4984.9 5053.0 4971.3 4972.1 4978.7 4991.3 5004.5 4944.0 4959.5 4974.0 4975.9 5019.8 5194.2 5232.8 5296.7 5308.9 5309.4 5852.2 5860.2 5871.9 5877.8 5898.1 5890.3 5897.3 5903.3 5913.0 5952.1 5493.6 5590.6 5597.3 5613.7 5640.9 5941.9 5991.6 5992.0 5996.6 6000.9 5764.6 5783.2 5800.1 5823.3 5882.0 5929.0 5963.1 5974.5 5983.7 6023.2 5828.7 5872.9 5893.7 5894.3 5915.5 5675.7 5757.4 5838.6 5885.8 5937.1 4542.2 4553.7 4563.4 4583.2 4593.8 4033.6 4050.0 4051.3 4057.1 4090.0 5421.9 5516.6 5552.4 5632.5 5657.3 5904.9 5944.0 5963.9 5989.7 5992.3 5536.1 5569.7 5578.0 5591.3 5611.7 5046.4 5123.3 5126.3 5127.9 5138.8 5973.5 6021.5 6025.6 6047.3 6069.1 5905.6 5966.7 5997.2 6007.3 6042.0 5853.8 5938.4 5966.4 6073.3 6081.1 5835.4 5863.4 5866.4 5873.4 5923.1 5893.1 5931.8 5947.3 5950.3 5959.2 5628.0 5660.1 5776.0 5781.1 5791.4 5786.4 5788.7 5798.1 5802.6 5805.2 5641.3 5677.4 5689.0 5718.2 5728.3 5637.6 5715.7 5748.4 5793.4 5848.0 5658.4 5660.9 5665.7 5696.5 5709.7 19:06:01 INFO - PROCESS | 14158 | 19:06:01 INFO - PROCESS | 14158 | [#1] ext.html Cycles:180 Average:46765.83 Median:20643.55 stddev:78210.39 (378.9%) stddev-sans-first:78352.85 19:06:01 INFO - PROCESS | 14158 | Values: 560.5 591.5 597.4 600.2 601.0 36564.5 36699.0 37092.8 37213.3 37301.0 41285.0 41475.4 41520.0 41715.8 41749.0 8557.0 8589.4 8663.4 8679.3 8704.6 8485.4 8538.1 8579.4 8604.1 8627.9 8589.2 8670.1 8671.7 8676.4 8697.7 8512.1 8524.5 8533.0 8563.4 8579.9 8471.7 8595.2 8602.4 8623.4 8626.0 38783.0 39213.0 39239.2 39249.2 39379.8 2934.7 2938.7 3049.3 3243.1 3268.3 29470.1 29972.6 30126.2 30201.0 30438.4 3768.7 3862.0 3883.1 3919.6 3931.8 248680.0 249834.0 250133.7 250369.0 251285.0 43968.2 44732.6 53570.7 53829.7 53836.7 62829.7 63757.4 64189.4 64275.7 64332.0 14583.1 14818.3 14831.5 14835.3 14840.3 10938.3 10963.6 10966.8 10969.7 10972.6 18356.2 18615.6 18695.6 18699.4 18703.8 7562.4 7782.5 7824.2 7869.8 7889.9 888.7 898.5 909.1 915.9 1071.6 25064.6 25257.0 25275.1 25371.6 25415.1 977.2 1015.2 1026.1 1107.9 1119.8 14859.6 15594.5 15620.1 15875.0 15883.6 346290.0 349847.0 352680.0 353033.0 353543.0 52714.5 52777.0 53325.0 53518.7 53663.7 1339.6 1362.1 1370.5 1374.3 1376.7 29056.9 30543.7 30922.5 32486.5 32657.2 48169.0 48784.8 48883.0 48945.0 48961.5 284235.2 286362.0 286857.0 287435.0 287714.0 41219.0 44861.0 44917.6 45277.8 45592.8 41891.0 42004.8 42114.4 42539.4 42728.4 33263.4 35436.6 35833.5 36017.1 36139.6 36150.0 36541.5 36795.6 37447.8 41014.4 33593.7 37518.4 38022.4 38047.2 38093.7 29687.9 32668.0 33132.5 33170.8 33206.0 25118.7 25128.0 25278.6 25474.9 25802.5 19:06:01 INFO - PROCESS | 14158 | 19:06:01 INFO - PROCESS | 14158 | [#2] jquery.html Cycles:180 Average:28306.85 Median:4224.09 stddev:84320.63 (1996.2%) stddev-sans-first:84531.04 19:06:01 INFO - PROCESS | 14158 | Values: 349.4 357.6 361.4 363.4 369.5 13905.8 14202.7 15741.4 16268.8 16675.2 15962.3 16391.4 16587.6 16628.8 16670.6 4767.4 4942.0 4951.8 4951.9 4955.8 4896.0 4960.4 5266.7 5372.6 5397.9 5334.2 5348.3 5351.0 5377.5 5394.5 5363.3 5993.2 6025.5 6032.0 6036.1 5342.8 5356.8 5357.1 5374.0 5390.3 18491.0 20316.7 20837.5 21082.0 21234.3 2044.6 2051.9 2056.4 2064.6 2106.2 9748.1 9767.5 9843.6 9961.8 9976.2 1771.7 1775.3 1804.4 1840.7 1841.9 58428.0 62382.4 62688.0 62978.0 63448.0 10330.9 10434.5 10473.3 10482.1 10502.4 13599.4 13614.1 13618.2 13626.6 13672.3 7260.0 7422.3 7458.3 7483.9 7490.5 7402.8 7431.0 7475.2 7476.3 7486.3 4092.4 4146.4 4216.2 4232.0 4249.1 1821.9 1833.3 1847.5 1871.2 1872.6 853.5 859.8 895.7 999.8 1034.6 15952.7 16835.8 16914.4 17098.4 17210.9 880.7 898.2 908.6 935.9 999.7 9702.6 9758.5 10249.4 10258.5 10316.3 502107.0 502694.3 514872.0 523619.0 530540.0 82992.2 83860.0 84558.0 85244.0 86120.1 1090.9 1091.2 1105.5 1111.7 1112.2 15892.1 15900.7 16224.0 16261.9 16370.0 36014.5 36466.0 36598.5 37123.4 38334.6 48684.8 49497.5 50156.0 51571.5 52171.5 9598.1 9829.8 9831.2 9847.1 9864.8 12890.3 16507.3 16746.6 16752.7 17305.6 9477.8 9743.4 9772.8 15240.3 15377.8 9616.1 9957.8 9973.2 10057.1 10239.7 9370.9 9463.8 9468.9 9551.2 9863.4 14811.2 14837.9 14957.1 14967.3 15306.2 13878.7 14101.0 14270.8 14432.4 14534.8 19:06:01 INFO - PROCESS | 14158 | 19:06:01 INFO - PROCESS | 14158 | [#3] mootools.html Cycles:180 Average:5447.07 Median:6189.44 stddev:2867.55 (46.3%) stddev-sans-first:2858.88 19:06:01 INFO - PROCESS | 14158 | Values: 1327.7 1338.3 1473.6 1796.1 1804.6 6948.6 7043.9 7445.0 7850.3 7872.3 7505.5 7740.5 7767.6 7817.8 7825.8 2265.0 2278.4 2279.7 2285.1 2291.4 2289.9 2294.2 2341.8 2355.6 2361.0 2313.9 2321.0 2342.6 2365.7 2370.2 2283.0 2307.3 2311.2 2315.5 2319.8 2305.4 2333.6 2335.0 2335.3 2337.2 7655.7 7681.7 7699.0 7720.6 7785.1 4753.7 4824.4 4842.3 4857.2 4863.0 3145.6 3149.0 3210.0 3216.8 3237.1 1019.8 1037.6 1046.6 1050.0 1083.1 10813.8 10851.8 10932.2 10942.9 10957.3 4282.4 4319.4 4375.2 4394.2 4398.2 9385.8 9408.9 9434.0 9440.5 9449.1 4824.6 4827.5 4833.5 4841.1 4858.0 3778.3 3867.7 4310.6 4380.7 4388.2 3686.9 3698.5 3701.7 3717.4 3725.3 1159.5 1162.1 1172.5 1174.1 1191.0 948.0 962.7 964.6 1035.4 1290.0 7325.6 7329.3 7355.7 7366.4 7383.4 470.4 473.2 474.4 475.9 478.7 5474.0 5483.5 5524.8 5527.5 5536.7 9218.8 9322.6 9462.3 9638.5 9701.3 9449.7 9452.0 9473.5 9511.3 9555.2 7151.2 7193.5 7211.4 7307.6 7333.3 6972.4 7010.3 7010.6 7026.1 7027.4 8251.3 8406.7 8478.8 8601.8 8642.9 8579.9 8626.0 8633.8 8697.3 8754.2 6005.1 6432.7 6677.6 6836.4 6908.4 7655.5 7678.5 7680.8 7726.7 7751.3 7001.8 7136.4 7182.5 7225.8 7300.5 7109.6 7114.6 7153.5 7213.4 7245.7 6573.2 6685.9 6734.9 6743.8 6764.0 6142.8 6180.2 6180.7 6198.2 6220.1 6219.2 6241.4 6243.1 6303.5 6363.5 19:06:01 INFO - PROCESS | 14158 | 19:06:01 INFO - PROCESS | 14158 | [#4] prototype.html Cycles:180 Average:5640.38 Median:6415.36 stddev:1730.07 (27.0%) stddev-sans-first:1688.29 19:06:01 INFO - PROCESS | 14158 | Values: 324.5 325.9 336.0 342.1 350.2 6337.6 6358.9 6379.5 6390.7 6473.5 6356.3 6381.8 6393.0 6403.2 6403.3 4853.1 4858.0 4858.8 4863.8 4874.2 4854.1 4861.3 4868.6 4881.0 4888.5 4635.3 4645.9 4726.9 4759.5 4795.2 4736.7 4742.5 4746.8 4749.9 4757.8 4109.2 4124.0 4126.6 4128.2 4141.1 5967.7 5981.4 5993.7 5994.1 5997.2 5481.7 5550.6 5563.5 5573.1 5576.6 6650.7 6669.6 6674.8 6681.5 6687.7 4549.5 4556.5 4572.2 4589.8 4604.5 6793.9 6896.4 6904.1 6963.4 6995.6 4681.3 4684.3 4685.4 4691.8 4696.1 4716.2 4738.9 4740.1 4748.0 4759.0 5527.1 5528.9 5529.0 5535.3 5541.8 6620.4 6738.6 6752.5 6764.5 6773.3 1648.6 1677.5 1679.8 1683.0 1686.4 1111.5 1111.9 1112.4 1125.3 1132.8 6412.9 6417.8 6424.9 6427.8 6433.5 6956.5 6990.1 7009.7 7013.8 7016.9 6298.1 6426.7 6433.3 6493.3 6519.5 3831.1 3842.2 3855.0 3861.5 3866.1 7209.1 7215.3 7218.6 7220.7 7229.1 7116.1 7219.5 7270.5 7295.7 7315.3 7140.2 7172.5 7187.9 7188.9 7210.6 7047.4 7051.4 7069.3 7079.9 7103.7 6797.5 7011.3 7015.4 7021.4 7021.9 7191.3 7209.6 7210.6 7215.3 7215.5 4706.8 4751.4 4758.2 4761.8 4763.9 6896.7 7053.1 7127.9 7133.9 7140.2 6811.5 6834.0 6837.8 6883.1 6896.8 6725.3 6881.3 6888.1 6893.6 6904.1 6743.9 6747.6 6753.3 6754.8 6757.9 6851.7 6859.5 6906.9 6907.2 6915.2 6515.7 6674.7 6715.8 6736.1 6740.8 19:06:01 INFO - PROCESS | 14158 | 19:06:01 INFO - PROCESS | 14158 | [#5] yui.html Cycles:180 Average:13146.26 Median:25662.20 stddev:15440.16 (60.2%) stddev-sans-first:15455.02 19:06:01 INFO - PROCESS | 14158 | Values: 663.8 681.1 748.7 776.4 779.1 13621.5 13870.4 13924.6 13968.5 13983.9 13042.6 13243.2 13246.5 13312.8 13384.1 784.1 786.3 796.2 796.8 797.1 785.1 789.1 789.7 790.8 796.5 815.6 820.2 824.2 824.6 827.8 818.6 819.1 820.8 821.5 823.2 605.5 605.9 606.3 607.4 607.8 13634.9 13680.2 13684.5 13691.2 13782.8 10805.0 11080.4 11401.5 11469.5 12951.5 10091.3 10123.3 10222.6 10378.2 10630.9 3528.8 3545.8 3584.5 3599.4 3612.8 45011.8 49987.8 50499.7 50698.2 50789.7 8854.8 9431.3 9533.3 9811.3 10134.0 17382.9 17404.8 17409.8 17476.7 17482.9 6980.9 7159.1 7212.6 7312.3 7434.9 3856.8 3886.0 3899.9 3939.2 4026.3 3109.2 3135.1 3136.8 3138.0 3144.9 566.3 571.1 583.6 584.1 585.5 475.7 492.4 534.6 545.0 565.9 7523.0 7551.8 7572.7 7624.7 7686.7 457.5 493.7 507.3 574.2 623.4 3551.7 3569.2 3597.9 3611.9 3659.8 54099.0 54409.7 54410.5 54470.5 55084.7 47025.0 47315.8 47405.5 47759.8 47762.0 42422.0 43404.3 44429.8 44673.0 45002.3 7093.4 7198.8 7574.6 7691.5 7765.1 31067.7 31919.0 32771.5 34484.8 36300.6 42999.0 43976.8 44293.6 44982.3 45176.8 10612.6 10663.6 10693.4 11031.8 11263.6 11023.6 11071.0 11309.8 11370.5 11569.4 9437.9 9479.6 9599.3 9615.9 9700.1 9379.5 9790.5 9799.7 9881.9 9932.0 9348.3 9498.8 9517.4 9525.7 9694.9 8509.2 8711.2 8720.2 8783.1 9050.1 7989.5 8315.0 8385.7 8388.6 8396.5 19:06:01 INFO - PROCESS | 14158 | -------- Summary: end -------- 19:06:01 INFO - PROCESS | 14158 | 19:06:02 INFO - TEST-INFO | 14158: exit 0 19:06:02 INFO - TEST-OK | dromaeo_css | took 1110412ms 19:06:02 INFO - TEST-START | kraken 19:06:02 INFO - operating with platform_type : linux_ 19:06:02 INFO - Initialising browser for kraken test... 19:06:02 INFO - TEST-INFO | started process 14396 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp663wN7/profile http://localhost:39164/getInfo.html) 19:06:05 INFO - PROCESS | 14396 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 19:06:06 INFO - PROCESS | 14396 | __metrics Screen width/height:1600/1200 19:06:06 INFO - PROCESS | 14396 | colorDepth:24 19:06:06 INFO - PROCESS | 14396 | Browser inner width/height: 1024/697 19:06:06 INFO - PROCESS | 14396 | __metrics 19:06:06 INFO - PROCESS | 14396 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:06:07 INFO - TEST-INFO | 14396: exit 0 19:06:07 INFO - Browser initialized. 19:06:07 INFO - Running cycle 1/1 for kraken test... 19:06:07 INFO - TEST-INFO | started process 14517 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp663wN7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:06:19 INFO - PROCESS | 14517 | RSS: Main: 151134208 19:06:19 INFO - PROCESS | 14517 | 19:06:21 INFO - PROCESS | 14517 | Cycle 1(1): loaded http://localhost:39164/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39164/tests/kraken/driver.html?testName=audio-beat-detection) 19:06:22 INFO - PROCESS | 14517 | RSS: Main: 152428544 19:06:22 INFO - PROCESS | 14517 | 19:06:25 INFO - PROCESS | 14517 | Cycle 1(1): loaded http://localhost:39164/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39164/tests/kraken/driver.html?testName=audio-dft) 19:06:25 INFO - PROCESS | 14517 | RSS: Main: 151244800 19:06:25 INFO - PROCESS | 14517 | 19:06:28 INFO - PROCESS | 14517 | Cycle 1(1): loaded http://localhost:39164/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39164/tests/kraken/driver.html?testName=audio-fft) 19:06:29 INFO - PROCESS | 14517 | RSS: Main: 146862080 19:06:29 INFO - PROCESS | 14517 | 19:06:31 INFO - PROCESS | 14517 | Cycle 1(1): loaded http://localhost:39164/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39164/tests/kraken/driver.html?testName=audio-oscillator) 19:06:31 INFO - PROCESS | 14517 | RSS: Main: 146944000 19:06:31 INFO - PROCESS | 14517 | 19:06:33 INFO - PROCESS | 14517 | Cycle 1(1): loaded http://localhost:39164/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39164/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:06:34 INFO - PROCESS | 14517 | RSS: Main: 146608128 19:06:34 INFO - PROCESS | 14517 | 19:06:37 INFO - PROCESS | 14517 | Cycle 1(1): loaded http://localhost:39164/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39164/tests/kraken/driver.html?testName=imaging-darkroom) 19:06:37 INFO - PROCESS | 14517 | RSS: Main: 147177472 19:06:37 INFO - PROCESS | 14517 | 19:06:41 INFO - PROCESS | 14517 | Cycle 1(1): loaded http://localhost:39164/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39164/tests/kraken/driver.html?testName=imaging-desaturate) 19:06:41 INFO - PROCESS | 14517 | RSS: Main: 147730432 19:06:41 INFO - PROCESS | 14517 | 19:06:44 INFO - PROCESS | 14517 | Cycle 1(1): loaded http://localhost:39164/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39164/tests/kraken/driver.html?testName=json-parse-financial) 19:06:45 INFO - PROCESS | 14517 | RSS: Main: 148357120 19:06:45 INFO - PROCESS | 14517 | 19:06:46 INFO - PROCESS | 14517 | Cycle 1(1): loaded http://localhost:39164/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39164/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:06:47 INFO - PROCESS | 14517 | RSS: Main: 148811776 19:06:47 INFO - PROCESS | 14517 | 19:06:49 INFO - PROCESS | 14517 | Cycle 1(1): loaded http://localhost:39164/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39164/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:06:49 INFO - PROCESS | 14517 | RSS: Main: 148262912 19:06:49 INFO - PROCESS | 14517 | 19:06:52 INFO - PROCESS | 14517 | Cycle 1(1): loaded http://localhost:39164/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39164/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:06:52 INFO - PROCESS | 14517 | RSS: Main: 148586496 19:06:52 INFO - PROCESS | 14517 | 19:06:55 INFO - PROCESS | 14517 | Cycle 1(1): loaded http://localhost:39164/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39164/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:06:55 INFO - PROCESS | 14517 | RSS: Main: 149180416 19:06:55 INFO - PROCESS | 14517 | 19:06:58 INFO - PROCESS | 14517 | Cycle 1(1): loaded http://localhost:39164/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39164/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:06:58 INFO - PROCESS | 14517 | RSS: Main: 148619264 19:06:58 INFO - PROCESS | 14517 | 19:07:00 INFO - PROCESS | 14517 | Cycle 1(1): loaded http://localhost:39164/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39164/tests/kraken/driver.html?testName=ai-astar) 19:07:00 INFO - PROCESS | 14517 | RSS: Main: 148578304 19:07:00 INFO - PROCESS | 14517 | 19:07:00 INFO - PROCESS | 14517 | __start_tp_report 19:07:00 INFO - PROCESS | 14517 | _x_x_mozilla_page_load 19:07:00 INFO - PROCESS | 14517 | _x_x_mozilla_page_load_details 19:07:00 INFO - PROCESS | 14517 | |i|pagename|runs| 19:07:00 INFO - PROCESS | 14517 | |0;ai-astar;109;107;112;109;112;122;108;111;109;110 19:07:00 INFO - PROCESS | 14517 | |1;audio-beat-detection;147;122;146;165;122;143;148;125;162;129 19:07:00 INFO - PROCESS | 14517 | |2;audio-dft;161;163;162;163;162;161;160;163;169;162 19:07:00 INFO - PROCESS | 14517 | |3;audio-fft;77;73;70;71;71;72;129;71;74;71 19:07:00 INFO - PROCESS | 14517 | |4;audio-oscillator;96;94;135;93;95;93;139;92;93;137 19:07:00 INFO - PROCESS | 14517 | |5;imaging-gaussian-blur;110;111;110;110;109;110;110;110;110;110 19:07:00 INFO - PROCESS | 14517 | |6;imaging-darkroom;147;147;146;146;145;147;146;147;147;146 19:07:00 INFO - PROCESS | 14517 | |7;imaging-desaturate;96;96;100;96;96;96;96;96;96;96 19:07:00 INFO - PROCESS | 14517 | |8;json-parse-financial;63;61;61;60;61;61;60;60;61;58 19:07:00 INFO - PROCESS | 14517 | |9;json-stringify-tinderbox;66;68;67;67;67;67;67;66;66;66 19:07:00 INFO - PROCESS | 14517 | |10;stanford-crypto-aes;83;85;83;85;83;84;85;85;86;85 19:07:00 INFO - PROCESS | 14517 | |11;stanford-crypto-ccm;116;126;125;119;119;134;121;128;120;121 19:07:00 INFO - PROCESS | 14517 | |12;stanford-crypto-pbkdf2;140;151;154;159;143;144;141;151;146;144 19:07:00 INFO - PROCESS | 14517 | |13;stanford-crypto-sha256-iterative;69;66;71;69;67;76;68;68;70;66 19:07:00 INFO - PROCESS | 14517 | __end_tp_report 19:07:00 INFO - PROCESS | 14517 | __start_cc_report 19:07:00 INFO - PROCESS | 14517 | _x_x_mozilla_cycle_collect,712 19:07:00 INFO - PROCESS | 14517 | __end_cc_report 19:07:00 INFO - PROCESS | 14517 | __startTimestamp1450753620739__endTimestamp 19:07:00 INFO - PROCESS | 14517 | 19:07:00 INFO - PROCESS | 14517 | ------- Summary: start ------- 19:07:00 INFO - PROCESS | 14517 | Number of tests: 14 19:07:00 INFO - PROCESS | 14517 | 19:07:00 INFO - PROCESS | 14517 | [#0] ai-astar Cycles:10 Average:110.90 Median:110.50 stddev:4.23 (3.8%) stddev-sans-first:4.43 19:07:00 INFO - PROCESS | 14517 | Values: 109.0 107.0 112.0 109.0 112.0 122.0 108.0 111.0 109.0 110.0 19:07:00 INFO - PROCESS | 14517 | 19:07:00 INFO - PROCESS | 14517 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:146.50 stddev:15.82 (10.8%) stddev-sans-first:16.63 19:07:00 INFO - PROCESS | 14517 | Values: 147.0 122.0 146.0 165.0 122.0 143.0 148.0 125.0 162.0 129.0 19:07:00 INFO - PROCESS | 14517 | 19:07:00 INFO - PROCESS | 14517 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.50 stddev:2.46 (1.5%) stddev-sans-first:2.54 19:07:00 INFO - PROCESS | 14517 | Values: 161.0 163.0 162.0 163.0 162.0 161.0 160.0 163.0 169.0 162.0 19:07:00 INFO - PROCESS | 14517 | 19:07:00 INFO - PROCESS | 14517 | [#3] audio-fft Cycles:10 Average:77.90 Median:71.50 stddev:18.07 (25.3%) stddev-sans-first:19.16 19:07:00 INFO - PROCESS | 14517 | Values: 77.0 73.0 70.0 71.0 71.0 72.0 129.0 71.0 74.0 71.0 19:07:00 INFO - PROCESS | 14517 | 19:07:00 INFO - PROCESS | 14517 | [#4] audio-oscillator Cycles:10 Average:106.70 Median:93.00 stddev:20.96 (22.5%) stddev-sans-first:21.87 19:07:00 INFO - PROCESS | 14517 | Values: 96.0 94.0 135.0 93.0 95.0 93.0 139.0 92.0 93.0 137.0 19:07:00 INFO - PROCESS | 14517 | 19:07:00 INFO - PROCESS | 14517 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 19:07:00 INFO - PROCESS | 14517 | Values: 110.0 111.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 19:07:00 INFO - PROCESS | 14517 | 19:07:00 INFO - PROCESS | 14517 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 19:07:00 INFO - PROCESS | 14517 | Values: 147.0 147.0 146.0 146.0 145.0 147.0 146.0 147.0 147.0 146.0 19:07:00 INFO - PROCESS | 14517 | 19:07:00 INFO - PROCESS | 14517 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.26 (1.3%) stddev-sans-first:1.33 19:07:00 INFO - PROCESS | 14517 | Values: 96.0 96.0 100.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 19:07:00 INFO - PROCESS | 14517 | 19:07:00 INFO - PROCESS | 14517 | [#8] json-parse-financial Cycles:10 Average:60.60 Median:61.00 stddev:1.26 (2.1%) stddev-sans-first:1.00 19:07:00 INFO - PROCESS | 14517 | Values: 63.0 61.0 61.0 60.0 61.0 61.0 60.0 60.0 61.0 58.0 19:07:00 INFO - PROCESS | 14517 | 19:07:00 INFO - PROCESS | 14517 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 19:07:00 INFO - PROCESS | 14517 | Values: 66.0 68.0 67.0 67.0 67.0 67.0 67.0 66.0 66.0 66.0 19:07:00 INFO - PROCESS | 14517 | 19:07:00 INFO - PROCESS | 14517 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:85.00 stddev:1.07 (1.3%) stddev-sans-first:1.01 19:07:00 INFO - PROCESS | 14517 | Values: 83.0 85.0 83.0 85.0 83.0 84.0 85.0 85.0 86.0 85.0 19:07:00 INFO - PROCESS | 14517 | 19:07:00 INFO - PROCESS | 14517 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:123.00 stddev:5.34 (4.3%) stddev-sans-first:5.05 19:07:00 INFO - PROCESS | 14517 | Values: 116.0 126.0 125.0 119.0 119.0 134.0 121.0 128.0 120.0 121.0 19:07:00 INFO - PROCESS | 14517 | 19:07:00 INFO - PROCESS | 14517 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.30 Median:148.50 stddev:6.18 (4.2%) stddev-sans-first:5.97 19:07:00 INFO - PROCESS | 14517 | Values: 140.0 151.0 154.0 159.0 143.0 144.0 141.0 151.0 146.0 144.0 19:07:00 INFO - PROCESS | 14517 | 19:07:00 INFO - PROCESS | 14517 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:2.94 (4.3%) stddev-sans-first:3.12 19:07:00 INFO - PROCESS | 14517 | Values: 69.0 66.0 71.0 69.0 67.0 76.0 68.0 68.0 70.0 66.0 19:07:00 INFO - PROCESS | 14517 | -------- Summary: end -------- 19:07:00 INFO - PROCESS | 14517 | 19:07:01 INFO - TEST-INFO | 14517: exit 0 19:07:01 INFO - TEST-OK | kraken | took 59602ms 19:07:01 INFO - TEST-START | v8_7 19:07:01 INFO - operating with platform_type : linux_ 19:07:01 INFO - Initialising browser for v8_7 test... 19:07:01 INFO - TEST-INFO | started process 14803 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYVNH8i/profile http://localhost:39164/getInfo.html) 19:07:05 INFO - PROCESS | 14803 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 19:07:06 INFO - PROCESS | 14803 | __metrics Screen width/height:1600/1200 19:07:06 INFO - PROCESS | 14803 | colorDepth:24 19:07:06 INFO - PROCESS | 14803 | Browser inner width/height: 1024/697 19:07:06 INFO - PROCESS | 14803 | __metrics 19:07:06 INFO - PROCESS | 14803 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:07:06 INFO - PROCESS | 14803 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 19:07:07 INFO - TEST-INFO | 14803: exit 0 19:07:07 INFO - Browser initialized. 19:07:07 INFO - Running cycle 1/1 for v8_7 test... 19:07:07 INFO - TEST-INFO | started process 14925 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpYVNH8i/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:07:19 INFO - PROCESS | 14925 | RSS: Main: 150781952 19:07:19 INFO - PROCESS | 14925 | 19:07:40 INFO - PROCESS | 14925 | Cycle 1(1): loaded http://localhost:39164/tests/v8_7/run.html (next: http://localhost:39164/tests/v8_7/run.html) 19:07:40 INFO - PROCESS | 14925 | RSS: Main: 146939904 19:07:40 INFO - PROCESS | 14925 | 19:07:40 INFO - PROCESS | 14925 | __start_tp_report 19:07:40 INFO - PROCESS | 14925 | _x_x_mozilla_page_load 19:07:40 INFO - PROCESS | 14925 | _x_x_mozilla_page_load_details 19:07:40 INFO - PROCESS | 14925 | |i|pagename|runs| 19:07:40 INFO - PROCESS | 14925 | |0;Richards;165.8649859014762 19:07:40 INFO - PROCESS | 14925 | |1;DeltaBlue;193.6858415649816 19:07:40 INFO - PROCESS | 14925 | |2;Encrypt;283.7684449489217 19:07:40 INFO - PROCESS | 14925 | |3;Decrypt;5301.587301587301 19:07:40 INFO - PROCESS | 14925 | |4;RayTrace;1062.6992561105208 19:07:40 INFO - PROCESS | 14925 | |5;Earley;697.8367062107467 19:07:40 INFO - PROCESS | 14925 | |6;Boyer;12219.512195121952 19:07:40 INFO - PROCESS | 14925 | |7;RegExp;25375 19:07:40 INFO - PROCESS | 14925 | |8;Splay;694.4444444444445 19:07:40 INFO - PROCESS | 14925 | |9;NavierStokes;4835.748792270531 19:07:40 INFO - PROCESS | 14925 | __end_tp_report 19:07:40 INFO - PROCESS | 14925 | __startTimestamp1450753660705__endTimestamp 19:07:40 INFO - PROCESS | 14925 | 19:07:40 INFO - PROCESS | 14925 | ------- Summary: start ------- 19:07:40 INFO - PROCESS | 14925 | Number of tests: 10 19:07:40 INFO - PROCESS | 14925 | 19:07:40 INFO - PROCESS | 14925 | [#0] Richards Cycles:1 Average:165.86 Median:165.86 stddev:0.00 (0.0%) 19:07:40 INFO - PROCESS | 14925 | Values: 165.9 19:07:40 INFO - PROCESS | 14925 | 19:07:40 INFO - PROCESS | 14925 | [#1] DeltaBlue Cycles:1 Average:193.69 Median:193.69 stddev:0.00 (0.0%) 19:07:40 INFO - PROCESS | 14925 | Values: 193.7 19:07:40 INFO - PROCESS | 14925 | 19:07:40 INFO - PROCESS | 14925 | [#2] Encrypt Cycles:1 Average:283.77 Median:283.77 stddev:0.00 (0.0%) 19:07:40 INFO - PROCESS | 14925 | Values: 283.8 19:07:40 INFO - PROCESS | 14925 | 19:07:40 INFO - PROCESS | 14925 | [#3] Decrypt Cycles:1 Average:5301.59 Median:5301.59 stddev:0.00 (0.0%) 19:07:40 INFO - PROCESS | 14925 | Values: 5301.6 19:07:40 INFO - PROCESS | 14925 | 19:07:40 INFO - PROCESS | 14925 | [#4] RayTrace Cycles:1 Average:1062.70 Median:1062.70 stddev:0.00 (0.0%) 19:07:40 INFO - PROCESS | 14925 | Values: 1062.7 19:07:40 INFO - PROCESS | 14925 | 19:07:40 INFO - PROCESS | 14925 | [#5] Earley Cycles:1 Average:697.84 Median:697.84 stddev:0.00 (0.0%) 19:07:40 INFO - PROCESS | 14925 | Values: 697.8 19:07:40 INFO - PROCESS | 14925 | 19:07:40 INFO - PROCESS | 14925 | [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 19:07:40 INFO - PROCESS | 14925 | Values: 12219.5 19:07:40 INFO - PROCESS | 14925 | 19:07:40 INFO - PROCESS | 14925 | [#7] RegExp Cycles:1 Average:25375.00 Median:25375.00 stddev:0.00 (0.0%) 19:07:40 INFO - PROCESS | 14925 | Values: 25375.0 19:07:40 INFO - PROCESS | 14925 | 19:07:40 INFO - PROCESS | 14925 | [#8] Splay Cycles:1 Average:694.44 Median:694.44 stddev:0.00 (0.0%) 19:07:40 INFO - PROCESS | 14925 | Values: 694.4 19:07:40 INFO - PROCESS | 14925 | 19:07:40 INFO - PROCESS | 14925 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 19:07:40 INFO - PROCESS | 14925 | Values: 4835.7 19:07:40 INFO - PROCESS | 14925 | -------- Summary: end -------- 19:07:40 INFO - PROCESS | 14925 | 19:07:41 INFO - TEST-INFO | 14925: exit 0 19:07:41 INFO - TEST-OK | v8_7 | took 39960ms 19:07:41 INFO - SUITE-END | took 1209s 19:07:41 INFO - Completed test suite (00:20:10) 19:07:41 INFO - Working with test: dromaeo_css 19:07:41 INFO - Generating results file: dromaeo_css 19:07:41 INFO - Working with test: kraken 19:07:41 INFO - Generating results file: kraken 19:07:41 INFO - javascript benchmark 19:07:41 INFO - Working with test: v8_7 19:07:41 INFO - Generating results file: v8_7 19:07:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:07:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 19:07:41 INFO - process_Request line: dromaeo_css 6979.71 graph.html#tests=[[72,63,43]] 19:07:41 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:07:41 INFO - process_Request line: kraken 1502.70 graph.html#tests=[[232,63,43]] 19:07:41 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:07:41 INFO - process_Request line: v8_7 21004.20 graph.html#tests=[[230,63,43]] 19:07:41 INFO - RETURN: dromaeo_css: 6979.71 19:07:41 INFO - RETURN: kraken: 1502.70 19:07:41 INFO - RETURN: v8_7: 21004.20 19:07:41 INFO - javascript benchmark 19:07:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3162.7153556179946, 3188.728958038567, 3215.4372984727665, 3222.13002489328, 3236.5145228215765, 5354.9196762048605, 5380.757865896035, 5384.91922621161, 5400.567954563635, 5403.594730395222, 5392.056390131721, 5402.162664786964, 5434.239206511082, 5440.945590544094, 5464.781408743645, 5002.374703162114, 5008.173651347523, 5055.9747201263945, 5087.84736457905, 5163.277141200235, 5141.76862041209, 5170.6122040847085, 5204.869878253036, 5224.346956630421, 5229.8954020919555, 4908.239222920453, 4935.432425271104, 4959.057779021974, 4984.87537811554, 5053.0399224147295, 4971.27916452116, 4972.0801651694555, 4978.676386034932, 4991.326170966946, 5004.474530174352, 4944.035912996967, 4959.479254678243, 4974.030064137494, 4975.925361119586, 5019.824306149304, 5194.194899790538, 5232.790688372498, 5296.655717378358, 5308.893822123536, 5309.41596424393, 5852.239208902815, 5860.208871802337, 5871.911921321183, 5877.764889404419, 5898.085796701475, 5890.293164820207, 5897.3218079920925, 5903.321118071433, 5912.965231084543, 5952.107183922403, 5493.615446918718, 5590.608657393984, 5597.300337457858, 5613.663180209201, 5640.943590564124, 5941.881162376815, 5991.580589358703, 5991.9700401498585, 5996.550258730613, 6000.909986350208, 5764.5676574257095, 5783.248177736951, 5800.129980502874, 5823.272090988627, 5881.970590147107, 5929.0, 5963.135345374896, 5974.462298393166, 5983.6708981005595, 6023.156758053876, 5828.708564571754, 5872.911906321408, 5893.705314734246, 5894.2926848778425, 5915.497182739516, 5675.659460432387, 5757.395473475309, 5838.591298609142, 5885.764569417175, 5937.050071988461, 4542.205114105084, 4553.658475614276, 4563.361129441881, 4583.243764778841, 4593.793279302439, 4033.6369726724733, 4049.959500405017, 4051.2505186539993, 4057.0668746188544, 4090.0, 5421.891562168814, 5516.586256030733, 5552.444755524496, 5632.5212356950115, 5657.32112146545, 5904.852378690567, 5944.0, 5963.850903727442, 5989.730462129215, 5992.310884248367, 5536.058869992111, 5569.749361278752, 5578.023845826964, 5591.27313449249, 5611.709306859445, 5046.39443266803, 5123.2827404163445, 5126.256692779526, 5127.897442051138, 5138.794448222029, 5973.492253158443, 6021.548383871227, 6025.578209525379, 6047.334793172748, 6069.119977603223, 5905.557083218861, 5966.731497082555, 5997.190379298913, 6007.30915944672, 6041.969790151021, 5853.824385268449, 5938.376470470711, 5966.403359663999, 6073.331933487401, 6081.118237855575, 5835.44563266489, 5863.442972917566, 5866.413358664099, 5873.353931067664, 5923.141144534105, 5893.116032595145, 5931.792387266425, 5947.31605865331, 5950.256217972754, 5959.1657167995645, 5628.0432326505415, 5660.094384898561, 5775.971120144372, 5781.132830075354, 5791.420857914343, 5786.42135786418, 5788.710564471844, 5798.072308430631, 5802.564807639359, 5805.245318108788, 5641.294838145232, 5677.3754886963225, 5688.971555142198, 5718.1708652246025, 5728.312602487728, 5637.605367624227, 5715.714214289185, 5748.39641837601, 5793.391693872083, 5847.970760146172, 5658.434156584473, 5660.943390566042, 5665.745041473061, 5696.458836410535, 5709.65742055478], "unit": "score", "name": "dojo.html", "value": 5431.538204629232}, {"lowerIsBetter": false, "replicates": [560.5179545590792, 591.5060924128355, 597.4115496236204, 600.1807532717842, 600.9849753756156, 36564.45153322699, 36699.0, 37092.81453592735, 37213.255734885286, 37301.0, 41285.0, 41475.377869331984, 41520.0, 41715.79142104293, 41749.0, 8556.999999999984, 8589.35579831512, 8663.350248731338, 8679.349048821332, 8704.608292626815, 8485.406021578492, 8538.06081331053, 8579.399442039059, 8604.139586041409, 8627.913720862805, 8589.184027517376, 8670.13298670131, 8671.69649062283, 8676.436031657922, 8697.652093916236, 8512.1487851215, 8524.488530688179, 8532.976042874832, 8563.357748168912, 8579.914200857975, 8471.661133554651, 8595.18345757152, 8602.35482338827, 8623.439476434012, 8625.956870215608, 38783.0, 39213.0, 39239.21521569581, 39249.21501569953, 39379.8031009846, 2934.7212014858555, 2938.6620538638117, 3049.329147587527, 3243.065026151337, 3268.346330733863, 29470.115896523137, 29972.550411743625, 30126.24684382886, 30201.0, 30438.391232175232, 3768.660820526166, 3862.0, 3883.126296583246, 3919.647231749128, 3931.842726290945, 248680.0, 249834.0, 250133.749331254, 250369.0, 251285.0, 43968.16350201475, 44732.55267447349, 53570.73214633902, 53829.73085134549, 53836.73081634567, 62829.68585157045, 63757.36242637607, 64189.35810641927, 64275.678621606596, 64332.0, 14583.125012499284, 14818.259087045604, 14831.480898168513, 14835.332410041574, 14840.332185051699, 10938.289011214405, 10963.56145754161, 10966.780664386668, 10969.670909872717, 10972.561097556169, 18356.173972171284, 18615.627687446446, 18695.626087478173, 18699.439016829518, 18703.81296187048, 7562.395008399315, 7782.49413788102, 7824.217578242244, 7869.842603147905, 7889.8816517752275, 888.7333799860016, 898.4878619187001, 909.1454033208763, 915.8809354783969, 1071.5553045486192, 25064.624030639556, 25257.0, 25275.11537096193, 25371.619425708628, 25415.093867959607, 977.154761131616, 1015.2487159501916, 1026.1021606094666, 1107.8725946516092, 1119.8152304869604, 14859.554213373616, 15594.532164035098, 15620.140892251035, 15875.0, 15883.602909927113, 346290.0, 349847.0, 352680.0, 353033.0, 353543.0, 52714.47285527172, 52777.0, 53325.0, 53518.73240633772, 53663.73168134134, 1339.6182088104842, 1362.1146254934174, 1370.520317888731, 1374.2647683489286, 1376.6764810269779, 29056.85471572713, 30543.694563054974, 30922.53616195804, 32486.512702309956, 32657.2350459171, 48169.0, 48784.75607621939, 48883.0, 48945.0, 48961.51038489569, 284235.1576484209, 286362.0, 286857.0, 287435.0, 287714.0, 41219.0, 44861.0, 44917.550824491336, 45277.773611131735, 45592.77203614094, 41891.0, 42004.78997604993, 42114.36828447637, 42539.36190957076, 42728.35907461453, 33263.439660940756, 35436.64563354333, 35833.520585225204, 36017.09957250985, 36139.638603613625, 36150.0, 36541.45187822238, 36795.63204368029, 37447.81276093602, 41014.38478422767, 33593.66406335905, 37518.43722344113, 38022.42966355452, 38047.239055219296, 38093.71437713746, 29687.85156074206, 32668.0, 33132.503012455316, 33170.83414582912, 33206.0, 25118.74881251164, 25128.0, 25278.620820688073, 25474.87262563675, 25802.48395032051], "unit": "score", "name": "ext.html", "value": 18436.437047619766}, {"lowerIsBetter": false, "replicates": [349.4478723616686, 357.6298531020393, 361.3513742831617, 363.4167161705463, 369.49563845351094, 13905.79141312881, 14202.71594568108, 15741.449049283277, 16268.755968660465, 16675.249613767395, 15962.281697323619, 16391.4263000795, 16587.585310367216, 16628.83371166288, 16670.58323541912, 4767.356406885069, 4942.0, 4951.826686065989, 4951.851444456672, 4955.826546070888, 4895.975520122394, 4960.429550601691, 5266.736663166846, 5372.57019438446, 5397.920415916813, 5334.173203153498, 5348.251244825728, 5350.973245133769, 5377.542908852753, 5394.487523685263, 5363.275957745694, 5993.160957465958, 6025.487833534155, 6032.034874420094, 6036.094585812098, 5342.759575819097, 5356.758945847446, 5357.142857142839, 5374.032674118657, 5390.272313237702, 18491.0, 20316.69524957127, 20837.479063023395, 21082.0, 21234.256801012045, 2044.570640165567, 2051.9487012824798, 2056.3728062940795, 2064.607724532334, 2106.2101711858054, 9748.122668959757, 9767.51162441875, 9843.60625574976, 9961.800763984753, 9976.152027077707, 1771.7430972509044, 1775.2632657447143, 1804.4316040447218, 1840.7146892231726, 1841.917113729872, 58428.0, 62382.37617623811, 62688.0, 62978.0, 63448.0, 10330.948345258375, 10434.478276086165, 10473.319234249902, 10482.056614904695, 10502.369857808557, 13599.388027538784, 13614.115082519604, 13618.18290902549, 13626.591202263948, 13672.31638418075, 7259.963700181571, 7422.257774222642, 7458.2541745826065, 7483.925160748432, 7490.5131166474, 7402.814929626802, 7430.962845185848, 7475.168583697029, 7476.25237476248, 7486.251374862471, 4092.3656833190903, 4146.440230568895, 4216.198922204771, 4231.978840105779, 4249.107687385684, 1821.8633602479601, 1833.2575307000686, 1847.4550007747746, 1871.2421469304954, 1872.597391560821, 853.5092321914924, 859.7807559072396, 895.6730793260543, 999.81003609314, 1034.591336422109, 15952.680946381008, 16835.831641683428, 16914.407995720092, 17098.401555945482, 17210.91394543019, 880.7269746378643, 898.167856929727, 908.63704443335, 935.9204467620192, 999.695092996643, 9702.563384647709, 9758.512074396253, 10249.436281004468, 10258.487075646188, 10316.277860549839, 502107.0, 502694.2709869629, 514872.0, 523619.0, 530540.0, 82992.17007829844, 83860.0, 84558.0, 85244.0, 86120.13879861121, 1090.8854570270166, 1091.24158709696, 1105.452366686645, 1111.7109551516664, 1112.1547623805966, 15892.12593307333, 15900.68198636044, 16224.0, 16261.918690406472, 16370.0, 36014.4597831038, 36466.0, 36598.451023235204, 37123.44314835226, 38334.6166538331, 48684.75657621689, 49497.50502495073, 50156.0, 51571.484285156665, 52171.47828521666, 9598.136167744937, 9829.754256143653, 9831.164351030242, 9847.064528869745, 9864.802703946025, 12890.29103399322, 16507.33970641161, 16746.581335466224, 16752.74870876962, 17305.56736081608, 9477.810443790948, 9743.366681165986, 9772.755681108029, 15240.314185861442, 15377.76933346023, 9616.134547890724, 9957.800843983225, 9973.202143828332, 10057.094861462503, 10239.7440063999, 9370.906290937004, 9463.763405914908, 9468.857967130636, 9551.235901128031, 9863.358881672955, 14811.185384803939, 14837.851621484078, 14957.102573845605, 14967.326470308644, 15306.23468826532, 13878.653033674238, 14101.0, 14270.785938210727, 14432.42270309176, 14534.781978270123], "unit": "score", "name": "jquery.html", "value": 8770.437727987837}, {"lowerIsBetter": false, "replicates": [1327.674719693675, 1338.27733024167, 1473.6242258224158, 1796.0570700382307, 1804.6390721855632, 6948.617826019567, 7043.929560704391, 7445.0, 7850.332721718646, 7872.33085187759, 7505.549667019983, 7740.458167928247, 7767.572783496906, 7817.804554886116, 7825.765227043198, 2264.954700905985, 2278.4190031541934, 2279.7492275849645, 2285.0745448093467, 2291.3927809130596, 2289.9084036638515, 2294.19703103914, 2341.8009469195053, 2355.611324131516, 2361.0319768894756, 2313.9190128345513, 2321.0483701682315, 2342.5549145662353, 2365.7161140663143, 2370.1822871109525, 2282.9543409131725, 2307.342407413879, 2311.17953126641, 2315.525317309956, 2319.7680231976838, 2305.4005958450757, 2333.5916214662366, 2335.007621760762, 2335.2994101769573, 2337.1703045418803, 7655.655495502716, 7681.692732290701, 7699.0, 7720.575368354738, 7785.065792104927, 4753.738544380058, 4824.445188803263, 4842.297866809328, 4857.1742803723455, 4863.0, 3145.5596216529702, 3149.0161198444835, 3209.983950080258, 3216.839158042112, 3237.14215732831, 1019.8322920256265, 1037.553851843707, 1046.638909576195, 1049.9972526237425, 1083.063150374928, 10813.83779243312, 10851.837222441669, 10932.180086493545, 10942.945285273523, 10957.342559446459, 4282.35764635301, 4319.373690814814, 4375.212461756914, 4394.209042372339, 4398.164348773723, 9385.765355866022, 9408.858867116998, 9433.952830235805, 9440.527973601429, 9449.102335278138, 4824.614030877521, 4827.541383568555, 4833.492483289274, 4841.104395686739, 4857.951420485821, 3778.263238668488, 3867.690584753213, 4310.633596144363, 4380.737155770664, 4388.232059389594, 3686.852525898934, 3698.537682789651, 3701.722370822199, 3717.386631205875, 3725.273571653556, 1159.5419809175496, 1162.0703437250336, 1172.5427083437467, 1174.1487421619258, 1191.0352614382377, 947.966821161256, 962.6967505235829, 964.5514835601479, 1035.409816404642, 1289.9935500322438, 7325.560466372035, 7329.340359367682, 7355.668994895243, 7366.410687145016, 7383.372413344819, 470.3720533088297, 473.15305602970983, 474.36198313268596, 475.9262314341283, 478.7271255384467, 5474.0, 5483.479069488392, 5524.751386187631, 5527.53015993637, 5536.667799932017, 9218.769530761785, 9322.627094916128, 9462.29032822541, 9638.518074096268, 9701.272404569685, 9449.716508504756, 9452.0, 9473.526323683789, 9511.286653501014, 9555.23558115349, 7151.177614574391, 7193.4604904631315, 7211.423086153095, 7307.5980821055355, 7333.339999399973, 6972.442204623517, 7010.334018268256, 7010.614416207158, 7026.1217347831525, 7027.402670773042, 8251.29863961546, 8406.747797566082, 8478.788030299045, 8601.784955376166, 8642.870356944524, 8579.914200858162, 8625.964884213934, 8633.784155396166, 8697.304215662858, 8754.21212090915, 6005.099235114768, 6432.742690292336, 6677.632730199885, 6836.38472537474, 6908.378245957888, 7655.46411751172, 7678.500897441649, 7680.80797980055, 7726.690932362642, 7751.3411360035025, 7001.8249543759775, 7136.3934065602925, 7182.533135346186, 7225.819354515969, 7300.525465844703, 7109.573425594274, 7114.608696521741, 7153.463490238357, 7213.422926165789, 7245.746398876014, 6573.244076931214, 6685.933140668531, 6734.9326506734305, 6743.763968261087, 6764.0, 6142.754289828536, 6180.196574445294, 6180.721867515883, 6198.163247961648, 6220.066989951543, 6219.191505104308, 6241.375862413723, 6243.063540468966, 6303.495720342454, 6363.490920726238], "unit": "score", "name": "mootools.html", "value": 4386.5077182039595}, {"lowerIsBetter": false, "replicates": [324.4840703281782, 325.9315543735814, 335.9714424273937, 342.08833458832214, 350.2329897524421, 6337.619742815428, 6358.936410635893, 6379.489640828734, 6390.680465976706, 6473.4821214302865, 6356.3008069112475, 6381.840453988652, 6392.968035159829, 6403.231612206541, 6403.263624683163, 4853.053654537367, 4858.0, 4858.78135483904, 4863.781129849148, 4874.220124780027, 4854.101991131634, 4861.295112208728, 4868.56182943535, 4881.0, 4888.535589119028, 4635.258358662614, 4645.86062418128, 4726.929096063562, 4759.524047595248, 4795.23276275796, 4736.668433209677, 4742.454617718955, 4746.810127594892, 4749.928751068736, 4757.833475828364, 4109.198706252282, 4123.989622542466, 4126.587341265879, 4128.174365126986, 4141.130362623852, 5967.731452084667, 5981.37195594465, 5993.670348130851, 5994.100884867261, 5997.22036135304, 5481.671099734029, 5550.58370622205, 5563.527100196488, 5573.136163894603, 5576.609637325389, 6650.7339706411685, 6669.599824010575, 6674.833129171761, 6681.498887583402, 6687.732490700366, 4549.522300158469, 4556.498785133633, 4572.199865023641, 4589.839355622537, 4604.539546045402, 6793.898091528631, 6896.413804826546, 6904.13698287714, 6963.373296403348, 6995.580265184105, 4681.321208424827, 4684.320773487893, 4685.390899183084, 4691.788869500812, 4696.131215725101, 4716.245400735866, 4738.857834264978, 4740.1230772307235, 4748.0, 4759.048190361941, 5527.060399732055, 5528.944710552843, 5528.9723551381985, 5535.335759708861, 5541.833744987657, 6620.437262832713, 6738.629375384401, 6752.527323087336, 6764.526483146133, 6773.322667733188, 1648.5878530367409, 1677.488366048367, 1679.7984241891052, 1682.9747553786704, 1686.3844696685867, 1111.5498223219608, 1111.8665760108838, 1112.3826276416667, 1125.2573301620891, 1132.818749000156, 6412.935870641327, 6417.7753778617525, 6424.871502570016, 6427.839304017343, 6433.453156481658, 6956.478264130211, 6990.09128813251, 7009.684564194624, 7013.754518591825, 7016.859662806817, 6298.149749783812, 6426.742930282736, 6433.292337842833, 6493.25327587324, 6519.478441724651, 3831.099691572478, 3842.212346468967, 3854.9807250963568, 3861.4593956846065, 3866.130120722815, 7209.062821833233, 7215.2582018833555, 7218.60297683622, 7220.711171553079, 7229.060222171084, 7116.146062472537, 7219.45854060937, 7270.527415717961, 7295.744648937261, 7315.30504602062, 7140.178879428829, 7172.462065345016, 7187.9281207188305, 7188.892166617505, 7210.567365957954, 7047.436205103477, 7051.43588512928, 7069.328413800681, 7079.929200707927, 7103.680334385069, 6797.524173307821, 7011.3339232772805, 7015.36861682451, 7021.438284937295, 7021.894671579828, 7191.316824901626, 7209.567425954459, 7210.603416812126, 7215.314545118205, 7215.494915355875, 4706.835260765857, 4751.358566593604, 4758.191107511662, 4761.785719642555, 4763.880902977453, 6896.724131034703, 7053.118360204974, 7127.8574428512175, 7133.928660713326, 7140.178879428932, 6811.4550835934, 6834.0, 6837.794866154023, 6883.139607549057, 6896.7586134485055, 6725.327467253235, 6881.346272104142, 6888.104546408935, 6893.551919125241, 6904.13698287714, 6743.9325606743305, 6747.561408508432, 6753.2909044549615, 6754.797356079325, 6757.932420675927, 6851.725930962705, 6859.451243900576, 6906.93093069083, 6907.240203577703, 6915.204751453647, 6515.73937042532, 6674.699638516181, 6715.7985260442265, 6736.124303840666, 6740.831479213059], "unit": "score", "name": "prototype.html", "value": 5068.54355319264}, {"lowerIsBetter": false, "replicates": [663.8103910709044, 681.131557264488, 748.6892939430137, 776.3982913242237, 779.0573406178523, 13621.523246686367, 13870.445182192725, 13924.582262532114, 13968.511102111428, 13983.86016139837, 13042.60872173834, 13243.205407675547, 13246.47014119434, 13312.800307995363, 13384.130031547942, 784.1022029775918, 786.2844811221789, 796.1640277708412, 796.8246985663145, 797.0873350014231, 785.132428666324, 789.1398375770409, 789.7393860026207, 790.7864876483346, 796.5181065455403, 815.6451943404609, 820.1962077164383, 824.2499325613693, 824.6124321568883, 827.8468483330573, 818.5907046476761, 819.1071731812353, 820.8358328334327, 821.5399376349263, 823.2014945502852, 605.5216379060581, 605.9303180134297, 606.2694453183902, 607.4077774170192, 607.7903123422412, 13634.863651363557, 13680.247586382746, 13684.452621895112, 13691.178529288274, 13782.793258101137, 10805.0, 11080.445977701163, 11401.48693308803, 11469.483873225641, 12951.546695865694, 10091.344062635904, 10123.341982771097, 10222.6422075227, 10378.221633377527, 10630.893691063067, 3528.8059156746367, 3545.840437180333, 3584.4981702561663, 3599.406097993828, 3612.7832330060282, 45011.77494112541, 49987.75006124946, 50499.747501262624, 50698.23952640713, 50789.746051269874, 8854.824255207472, 9431.292653050912, 9533.285003624756, 9811.31320807551, 10134.0, 17382.913085434746, 17404.825951740575, 17409.825901741075, 17476.737848932276, 17482.912585437247, 6980.93019069813, 7159.140903091662, 7212.603306818175, 7312.268773122752, 7434.888476672854, 3856.7685938843197, 3885.980570097188, 3899.922001559953, 3939.2121575684405, 4026.315526360526, 3109.207152176226, 3135.1064946490596, 3136.8274744888795, 3138.0272115644225, 3144.9371012579622, 566.3458705195424, 571.0606053042721, 583.5973178506816, 584.0509172594534, 585.4672248254153, 475.65990316923563, 492.3992728870772, 534.6444614331426, 544.9700066873612, 565.926429564154, 7523.0, 7551.773446796605, 7572.697092116364, 7624.656890439944, 7686.730964416219, 457.5127489224032, 493.73091665042637, 507.2821956930975, 574.1789241384777, 623.3610549187028, 3551.6803487685715, 3569.161247106928, 3597.874074407383, 3611.8735844245325, 3659.835307411173, 54099.0, 54409.72795136078, 54410.45589544054, 54470.45529544733, 55084.72457637767, 47025.0, 47315.76342118267, 47405.5259447408, 47759.761201194466, 47762.0, 42422.0, 43404.34893476601, 44429.777851110535, 44673.0, 45002.32496512555, 7093.3970612498515, 7198.820029499095, 7574.580020326234, 7691.538507689556, 7765.145833958373, 31067.689323107385, 31919.042428727174, 32771.50842737313, 34484.82757586196, 36300.63699362973, 42999.0, 43976.78011609922, 44293.55706442894, 44982.325265121704, 45176.77411612921, 10612.575496980035, 10663.626773063215, 10693.411862347646, 11031.83452248233, 11263.605773797877, 11023.559057637605, 11071.0, 11309.830352544883, 11370.54517819278, 11569.421528923353, 9437.905620943977, 9479.573419196015, 9599.328047036919, 9615.9038409615, 9700.078492543196, 9379.484128373006, 9790.510474476105, 9799.657012004545, 9881.851772223567, 9931.997941451114, 9348.345615806827, 9498.810023799348, 9517.381370210915, 9525.666601668909, 9694.854577181206, 8509.191626795444, 8711.172438618321, 8720.171583699539, 8783.121687831166, 9050.094990500897, 7989.52062876206, 8315.04376996653, 8385.706500272461, 8388.580570971304, 8396.496210227406], "unit": "score", "name": "yui.html", "value": 5920.548683262955}], "name": "dromaeo_css", "value": 6979.706253423734}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 107.0, 112.0, 109.0, 112.0, 122.0, 108.0, 111.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [147.0, 122.0, 146.0, 165.0, 122.0, 143.0, 148.0, 125.0, 162.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 140.9}, {"lowerIsBetter": true, "replicates": [161.0, 163.0, 162.0, 163.0, 162.0, 161.0, 160.0, 163.0, 169.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [77.0, 73.0, 70.0, 71.0, 71.0, 72.0, 129.0, 71.0, 74.0, 71.0], "unit": "score", "name": "audio-fft", "value": 77.9}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 135.0, 93.0, 95.0, 93.0, 139.0, 92.0, 93.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 145.0, 147.0, 146.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 100.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [63.0, 61.0, 61.0, 60.0, 61.0, 61.0, 60.0, 60.0, 61.0, 58.0], "unit": "score", "name": "json-parse-financial", "value": 60.6}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.7}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 83.0, 85.0, 83.0, 84.0, 85.0, 85.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.4}, {"lowerIsBetter": true, "replicates": [116.0, 126.0, 125.0, 119.0, 119.0, 134.0, 121.0, 128.0, 120.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [140.0, 151.0, 154.0, 159.0, 143.0, 144.0, 141.0, 151.0, 146.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.3}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 71.0, 69.0, 67.0, 76.0, 68.0, 68.0, 70.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.0}], "name": "kraken", "value": 1502.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.8649859014762], "unit": "score", "name": "Richards", "value": 212.835758}, {"lowerIsBetter": false, "replicates": [193.6858415649816], "unit": "score", "name": "DeltaBlue", "value": 341.3672340000001}, {"lowerIsBetter": false, "replicates": [283.7684449489217], "unit": "score", "name": "Encrypt", "value": 938.0218440000002}, {"lowerIsBetter": false, "replicates": [5301.587301587301], "unit": "score", "name": "Decrypt", "value": 50.20779341317366}, {"lowerIsBetter": false, "replicates": [1062.6992561105208], "unit": "score", "name": "RayTrace", "value": 696.3296489999998}, {"lowerIsBetter": false, "replicates": [697.8367062107467], "unit": "score", "name": "Earley", "value": 955.041479}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [25375.0], "unit": "score", "name": "RegExp", "value": 35.90088669950742}, {"lowerIsBetter": false, "replicates": [694.4444444444445], "unit": "score", "name": "Splay", "value": 117.34703999999996}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21004.201246329365}]} 19:07:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21004.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1502.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6979.71"}}} 19:07:41 INFO - Return code: 0 19:07:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 19:07:41 INFO - # TBPL SUCCESS # 19:07:41 INFO - Running post-action listener: _resource_record_post_action 19:07:41 INFO - Running post-run listener: _resource_record_post_run 19:07:43 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 172032; Write bytes: 560521216; Read time: 324; Write time: 616536 19:07:43 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 4096; Write bytes: 235118592; Read time: 216; Write time: 404852 19:07:43 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 167936; Write bytes: 325402624; Read time: 108; Write time: 211684 19:07:43 INFO - Running post-run listener: _upload_blobber_files 19:07:43 INFO - Blob upload gear active. 19:07:43 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 19:07:43 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:07:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 19:07:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 19:07:43 INFO - (blobuploader) - INFO - Open directory for files ... 19:07:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:07:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:07:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:44 INFO - (blobuploader) - INFO - Done attempting. 19:07:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:07:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:07:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:45 INFO - (blobuploader) - INFO - Done attempting. 19:07:45 INFO - (blobuploader) - INFO - Iteration through files over. 19:07:45 INFO - Return code: 0 19:07:45 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 19:07:45 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 19:07:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3a2982de6d2840b72ce4c3d69b5b51bc6ecfbef9cfa0599be6074e7dbb2301308ab262341ad5ff018a2117ef2de82c76b8c1f2340ad0efc61329e66d0d394dab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5a97088238e3d64192d375c8073beb4873ab5b99f2cc07589df977c89ee3264f27e2a2c5e821db7599618b47ee2bbed38d5ac40ebdffb7db31a74c7f17a7d3a4"} 19:07:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 19:07:45 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 19:07:45 INFO - Contents: 19:07:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3a2982de6d2840b72ce4c3d69b5b51bc6ecfbef9cfa0599be6074e7dbb2301308ab262341ad5ff018a2117ef2de82c76b8c1f2340ad0efc61329e66d0d394dab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5a97088238e3d64192d375c8073beb4873ab5b99f2cc07589df977c89ee3264f27e2a2c5e821db7599618b47ee2bbed38d5ac40ebdffb7db31a74c7f17a7d3a4"} 19:07:45 INFO - Copying logs to upload dir... 19:07:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1272.458206 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2015-12-21 19:07:44.925334) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 19:07:44.928955) ========= 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=820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3a2982de6d2840b72ce4c3d69b5b51bc6ecfbef9cfa0599be6074e7dbb2301308ab262341ad5ff018a2117ef2de82c76b8c1f2340ad0efc61329e66d0d394dab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5a97088238e3d64192d375c8073beb4873ab5b99f2cc07589df977c89ee3264f27e2a2c5e821db7599618b47ee2bbed38d5ac40ebdffb7db31a74c7f17a7d3a4"} build_url:https://queue.taskcluster.net/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/Mfk7r46BRSyo2e1CM10cQg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3a2982de6d2840b72ce4c3d69b5b51bc6ecfbef9cfa0599be6074e7dbb2301308ab262341ad5ff018a2117ef2de82c76b8c1f2340ad0efc61329e66d0d394dab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5a97088238e3d64192d375c8073beb4873ab5b99f2cc07589df977c89ee3264f27e2a2c5e821db7599618b47ee2bbed38d5ac40ebdffb7db31a74c7f17a7d3a4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 19:07:44.954628) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:07:44.955018) ========= 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=820bb6602ddf640013a48df2000001a9-1450752111.430847-1083944991 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 19:07:45.036522) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 19:07:45.036872) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 19:07:45.037193) ========= ========= Total master_lag: 0.21 =========