builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-039 starttime: 1452279449.08 results: success (0) buildid: 20160108083159 builduid: ea5fd84944cc4c96adc6f4dc9e3a28d3 revision: be73ca2ad9b5a49d5ca22b870538a683cdc13379 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:29.081966) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:29.082374) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:29.082827) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004291 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:29.119552) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:29.119824) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:29.170038) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:29.170299) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024625 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:29.217401) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:29.217662) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:29.218038) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:29.218310) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-08 10:57:29-- 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% 43.8M=0s 2016-01-08 10:57:29 (43.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.218937 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:29.448904) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:29.449205) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.129305 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:29.589827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:29.590183) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev be73ca2ad9b5a49d5ca22b870538a683cdc13379 --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/b2g-inbound --rev be73ca2ad9b5a49d5ca22b870538a683cdc13379 --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=5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-08 10:57:29,733 truncating revision to first 12 chars 2016-01-08 10:57:29,733 Setting DEBUG logging. 2016-01-08 10:57:29,733 attempt 1/10 2016-01-08 10:57:29,733 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/be73ca2ad9b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-08 10:57:29,986 unpacking tar archive at: b2g-inbound-be73ca2ad9b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.520866 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:30.126068) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:30.126381) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:30.134571) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:30.134815) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-08 10:57:30.135207) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-08 10:57:30.135480) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:57:30 INFO - MultiFileLogger online at 20160108 10:57:30 in /builds/slave/test-pgo 10:57:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 10:57:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 10:57:30 INFO - {'append_to_log': False, 10:57:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 10:57:30 INFO - 'blob_upload_branch': 'B2G-Inbound', 10:57:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 10:57:30 INFO - 'branch': 'B2G-Inbound', 10:57:30 INFO - 'buildbot_json_path': 'buildprops.json', 10:57:30 INFO - 'config_files': ('talos/linux_config.py',), 10:57:30 INFO - 'default_actions': ('clobber', 10:57:30 INFO - 'read-buildbot-config', 10:57:30 INFO - 'download-and-extract', 10:57:30 INFO - 'populate-webroot', 10:57:30 INFO - 'create-virtualenv', 10:57:30 INFO - 'install', 10:57:30 INFO - 'run-tests'), 10:57:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:57:30 INFO - 'download_minidump_stackwalk': True, 10:57:30 INFO - 'download_symbols': 'ondemand', 10:57:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:57:30 INFO - 'tooltool.py': '/tools/tooltool.py', 10:57:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:57:30 INFO - '/tools/misc-python/virtualenv.py')}, 10:57:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:57:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:57:30 INFO - 'installer_path': 'installer.exe', 10:57:30 INFO - 'log_level': 'info', 10:57:30 INFO - 'log_name': 'talos', 10:57:30 INFO - 'log_to_console': True, 10:57:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:57:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:57:30 INFO - 'opt_config_files': (), 10:57:30 INFO - 'pip_index': False, 10:57:30 INFO - 'sps_profile': False, 10:57:30 INFO - 'sps_profile_interval': 0, 10:57:30 INFO - 'suite': 'dromaeojs', 10:57:30 INFO - 'system_bits': '32', 10:57:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:57:30 INFO - 'title': 'talos-linux64-ix-039', 10:57:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:57:30 INFO - 'use_talos_json': True, 10:57:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 10:57:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:57:30 INFO - 'work_dir': 'build'} 10:57:30 INFO - ##### 10:57:30 INFO - ##### Running clobber step. 10:57:30 INFO - ##### 10:57:30 INFO - Running pre-action listener: _resource_record_pre_action 10:57:30 INFO - Running main action method: clobber 10:57:30 INFO - rmtree: /builds/slave/test-pgo/build 10:57:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 10:57:31 INFO - Running post-action listener: _resource_record_post_action 10:57:31 INFO - ##### 10:57:31 INFO - ##### Running read-buildbot-config step. 10:57:31 INFO - ##### 10:57:31 INFO - Running pre-action listener: _resource_record_pre_action 10:57:31 INFO - Running main action method: read_buildbot_config 10:57:31 INFO - Using buildbot properties: 10:57:31 INFO - { 10:57:31 INFO - "project": "", 10:57:31 INFO - "product": "firefox", 10:57:31 INFO - "script_repo_revision": "production", 10:57:31 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 10:57:31 INFO - "repository": "", 10:57:31 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 10:57:31 INFO - "buildid": "20160108083159", 10:57:31 INFO - "pgo_build": "True", 10:57:31 INFO - "basedir": "/builds/slave/test-pgo", 10:57:31 INFO - "buildnumber": 197, 10:57:31 INFO - "slavename": "talos-linux64-ix-039", 10:57:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:57:31 INFO - "platform": "ubuntu64_hw", 10:57:31 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 10:57:31 INFO - "branch": "b2g-inbound", 10:57:31 INFO - "repo_path": "integration/b2g-inbound", 10:57:31 INFO - "revision": "be73ca2ad9b5a49d5ca22b870538a683cdc13379", 10:57:31 INFO - "stage_platform": "linux64-pgo", 10:57:31 INFO - "builduid": "ea5fd84944cc4c96adc6f4dc9e3a28d3", 10:57:31 INFO - "slavebuilddir": "test" 10:57:31 INFO - } 10:57:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:57:31 INFO - Running post-action listener: _resource_record_post_action 10:57:31 INFO - ##### 10:57:31 INFO - ##### Running download-and-extract step. 10:57:31 INFO - ##### 10:57:31 INFO - Running pre-action listener: _resource_record_pre_action 10:57:31 INFO - Running main action method: download_and_extract 10:57:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 10:57:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:31 INFO - https://queue.taskcluster.net/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:57:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/test_packages.json 10:57:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/test_packages.json 10:57:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 10:57:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 10:57:32 INFO - Downloaded 1302 bytes. 10:57:32 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 10:57:32 INFO - Using the following test package requirements: 10:57:32 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:57:32 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:57:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:57:32 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:57:32 INFO - u'jsshell-linux-x86_64.zip'], 10:57:32 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:57:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:57:32 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:57:32 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:57:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:57:32 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:57:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:57:32 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:57:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:57:32 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:57:32 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:57:32 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:57:32 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:57:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:32 INFO - https://queue.taskcluster.net/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:57:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:57:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:57:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/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 10:57:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/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 10:57:34 INFO - Downloaded 24028001 bytes. 10:57:34 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 10:57:34 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:57:34 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 10:57:35 INFO - Return code: 0 10:57:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:35 INFO - https://queue.taskcluster.net/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:57:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:57:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:57:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/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 10:57:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/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 10:57:36 INFO - Downloaded 24028001 bytes. 10:57:36 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 10:57:36 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:57:36 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 10:57:37 INFO - Return code: 0 10:57:37 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')]} 10:57:37 INFO - https://queue.taskcluster.net/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:57:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:57:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:57:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/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 10:57:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/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 10:57:38 INFO - Downloaded 11132285 bytes. 10:57:38 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 10:57:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:57:38 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 10:57:39 INFO - Return code: 0 10:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:39 INFO - https://queue.taskcluster.net/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:57:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:57:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:57:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/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 10:57:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fUwbbSMvSLOaAoB8aOYlCA/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 10:57:40 INFO - Downloaded 55915369 bytes. 10:57:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:57:40 INFO - mkdir: /builds/slave/test-pgo/properties 10:57:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 10:57:40 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 10:57:40 INFO - Contents: 10:57:40 INFO - build_url:https://queue.taskcluster.net/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:57:40 INFO - Running post-action listener: _resource_record_post_action 10:57:40 INFO - Running post-action listener: set_extra_try_arguments 10:57:40 INFO - ##### 10:57:40 INFO - ##### Running populate-webroot step. 10:57:40 INFO - ##### 10:57:40 INFO - Running pre-action listener: _resource_record_pre_action 10:57:40 INFO - Running main action method: populate_webroot 10:57:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:57:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:57:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:57:40 INFO - '--tppagecycles', 10:57:40 INFO - '7'], 10:57:40 INFO - 'tests': ['tsvgm']}}, 10:57:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:57:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:57:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:57:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:57:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:57:40 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:57:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:57:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:40 INFO - 'talos_options': ['--e10s'], 10:57:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:57:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:40 INFO - 'tests': ['damp', 'tps']}, 10:57:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:40 INFO - 'talos_options': ['--e10s'], 10:57:40 INFO - 'tests': ['damp', 'tps']}, 10:57:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:57:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:57:40 INFO - 'other': {'tests': ['a11yr', 10:57:40 INFO - 'ts_paint', 10:57:40 INFO - 'tpaint', 10:57:40 INFO - 'sessionrestore', 10:57:40 INFO - 'sessionrestore_no_auto_restore']}, 10:57:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:57:40 INFO - 'tests': ['a11yr', 10:57:40 INFO - 'ts_paint', 10:57:40 INFO - 'tpaint', 10:57:40 INFO - 'sessionrestore', 10:57:40 INFO - 'sessionrestore_no_auto_restore']}, 10:57:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:57:40 INFO - 'tests': ['a11yr', 10:57:40 INFO - 'ts_paint', 10:57:40 INFO - 'tpaint', 10:57:40 INFO - 'sessionrestore', 10:57:40 INFO - 'sessionrestore_no_auto_restore']}, 10:57:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:57:40 INFO - 'tests': ['a11yr', 10:57:40 INFO - 'ts_paint', 10:57:40 INFO - 'tpaint', 10:57:40 INFO - 'sessionrestore', 10:57:40 INFO - 'sessionrestore_no_auto_restore']}, 10:57:40 INFO - 'other_l64': {'tests': ['a11yr', 10:57:40 INFO - 'ts_paint', 10:57:40 INFO - 'tpaint', 10:57:40 INFO - 'sessionrestore', 10:57:40 INFO - 'sessionrestore_no_auto_restore']}, 10:57:40 INFO - 'other_nol64': {'tests': ['a11yr', 10:57:40 INFO - 'ts_paint', 10:57:40 INFO - 'tpaint', 10:57:40 INFO - 'sessionrestore', 10:57:40 INFO - 'sessionrestore_no_auto_restore']}, 10:57:40 INFO - 'svgr': {'tests': ['tsvgx', 10:57:40 INFO - 'tsvgr_opacity', 10:57:40 INFO - 'tart', 10:57:40 INFO - 'tscrollx', 10:57:40 INFO - 'cart']}, 10:57:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:57:40 INFO - 'tests': ['tsvgx', 10:57:40 INFO - 'tsvgr_opacity', 10:57:40 INFO - 'tart', 10:57:40 INFO - 'tscrollx', 10:57:40 INFO - 'cart']}, 10:57:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:40 INFO - 'tests': ['tp5o']}, 10:57:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:40 INFO - 'talos_options': ['--e10s'], 10:57:40 INFO - 'tests': ['tp5o']}, 10:57:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:40 INFO - 'talos_options': ['--xperf_path', 10:57:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:57:40 INFO - 'tests': ['tp5n']}, 10:57:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:40 INFO - 'talos_options': ['--e10s', 10:57:40 INFO - '--xperf_path', 10:57:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:57:40 INFO - 'tests': ['tp5n']}}, 10:57:40 INFO - 'talos.zip': {'path': '', 10:57:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:57:40 INFO - Running post-action listener: _resource_record_post_action 10:57:40 INFO - ##### 10:57:40 INFO - ##### Running create-virtualenv step. 10:57:40 INFO - ##### 10:57:40 INFO - Running pre-action listener: _resource_record_pre_action 10:57:40 INFO - Running main action method: create_virtualenv 10:57:40 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 10:57:40 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 10:57:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 10:57:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:57:41 INFO - Using real prefix '/usr' 10:57:41 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 10:57:42 INFO - Installing distribute.............................................................................................................................................................................................done. 10:57:44 INFO - Installing pip.................done. 10:57:44 INFO - Return code: 0 10:57:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 10:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06f5302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb840>, '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 0x1e286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', '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 10:57:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 10:57:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:57:44 INFO - Using env: {'DISPLAY': ':0', 10:57:44 INFO - 'HOME': '/home/cltbld', 10:57:44 INFO - 'LANG': 'en_US.UTF-8', 10:57:44 INFO - 'LANGUAGE': 'en_US:en', 10:57:44 INFO - 'LOGNAME': 'cltbld', 10:57:44 INFO - 'MAIL': '/var/mail/cltbld', 10:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:44 INFO - 'MOZ_NO_REMOTE': '1', 10:57:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:44 INFO - 'NO_EM_RESTART': '1', 10:57:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:44 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:44 INFO - 'SHELL': '/bin/bash', 10:57:44 INFO - 'SHLVL': '1', 10:57:44 INFO - 'TERM': 'linux', 10:57:44 INFO - 'TMOUT': '86400', 10:57:44 INFO - 'USER': 'cltbld', 10:57:44 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', 10:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:44 INFO - '_': '/tools/buildbot/bin/python'} 10:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:57:44 INFO - Cleaning up... 10:57:44 INFO - Return code: 0 10:57:44 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 10:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:44 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06f5302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb840>, '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 0x1e286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', '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 10:57:44 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 10:57:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:57:44 INFO - Using env: {'DISPLAY': ':0', 10:57:44 INFO - 'HOME': '/home/cltbld', 10:57:44 INFO - 'LANG': 'en_US.UTF-8', 10:57:44 INFO - 'LANGUAGE': 'en_US:en', 10:57:44 INFO - 'LOGNAME': 'cltbld', 10:57:44 INFO - 'MAIL': '/var/mail/cltbld', 10:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:44 INFO - 'MOZ_NO_REMOTE': '1', 10:57:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:44 INFO - 'NO_EM_RESTART': '1', 10:57:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:44 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:44 INFO - 'SHELL': '/bin/bash', 10:57:44 INFO - 'SHLVL': '1', 10:57:44 INFO - 'TERM': 'linux', 10:57:44 INFO - 'TMOUT': '86400', 10:57:44 INFO - 'USER': 'cltbld', 10:57:44 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', 10:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:44 INFO - '_': '/tools/buildbot/bin/python'} 10:57:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:45 INFO - Downloading/unpacking psutil>=0.7.1 10:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:46 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 10:57:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:57:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 10:57:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:57:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:57:48 INFO - Installing collected packages: psutil 10:57:48 INFO - Running setup.py install for psutil 10:57:48 INFO - building 'psutil._psutil_linux' extension 10:57:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:57:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:57:48 INFO - building 'psutil._psutil_posix' extension 10:57:48 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:57:48 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:57:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:57:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:57:49 INFO - Successfully installed psutil 10:57:49 INFO - Cleaning up... 10:57:49 INFO - Return code: 0 10:57:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 10:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f06f5302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb840>, '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 0x1e286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', '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 10:57:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 10:57:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:57:49 INFO - Using env: {'DISPLAY': ':0', 10:57:49 INFO - 'HOME': '/home/cltbld', 10:57:49 INFO - 'LANG': 'en_US.UTF-8', 10:57:49 INFO - 'LANGUAGE': 'en_US:en', 10:57:49 INFO - 'LOGNAME': 'cltbld', 10:57:49 INFO - 'MAIL': '/var/mail/cltbld', 10:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:49 INFO - 'MOZ_NO_REMOTE': '1', 10:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:49 INFO - 'NO_EM_RESTART': '1', 10:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:49 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:49 INFO - 'SHELL': '/bin/bash', 10:57:49 INFO - 'SHLVL': '1', 10:57:49 INFO - 'TERM': 'linux', 10:57:49 INFO - 'TMOUT': '86400', 10:57:49 INFO - 'USER': 'cltbld', 10:57:49 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', 10:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:49 INFO - '_': '/tools/buildbot/bin/python'} 10:57:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:49 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:57:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:57:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:57:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:57:51 INFO - Installing collected packages: mozsystemmonitor 10:57:51 INFO - Running setup.py install for mozsystemmonitor 10:57:51 INFO - Successfully installed mozsystemmonitor 10:57:51 INFO - Cleaning up... 10:57:51 INFO - Return code: 0 10:57:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 10:57:51 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')]} 10:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:51 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')]} 10:57:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:51 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 0x7f06f5302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb840>, '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 0x1e286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', '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 10:57:51 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 10:57:51 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 10:57:51 INFO - Using env: {'DISPLAY': ':0', 10:57:51 INFO - 'HOME': '/home/cltbld', 10:57:51 INFO - 'LANG': 'en_US.UTF-8', 10:57:51 INFO - 'LANGUAGE': 'en_US:en', 10:57:51 INFO - 'LOGNAME': 'cltbld', 10:57:51 INFO - 'MAIL': '/var/mail/cltbld', 10:57:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:51 INFO - 'MOZ_NO_REMOTE': '1', 10:57:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:51 INFO - 'NO_EM_RESTART': '1', 10:57:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:51 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:51 INFO - 'SHELL': '/bin/bash', 10:57:51 INFO - 'SHLVL': '1', 10:57:51 INFO - 'TERM': 'linux', 10:57:51 INFO - 'TMOUT': '86400', 10:57:51 INFO - 'USER': 'cltbld', 10:57:51 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', 10:57:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:51 INFO - '_': '/tools/buildbot/bin/python'} 10:57:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:51 INFO - Downloading/unpacking blobuploader==1.2.4 10:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:53 INFO - Downloading blobuploader-1.2.4.tar.gz 10:57:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:57:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:57:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:53 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 10:57:53 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 10:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:57:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 10:57:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:53 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 10:57:53 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 10:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:54 INFO - Downloading docopt-0.6.1.tar.gz 10:57:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:57:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 10:57:54 INFO - Installing collected packages: blobuploader, requests, docopt 10:57:54 INFO - Running setup.py install for blobuploader 10:57:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:57:54 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 10:57:54 INFO - Running setup.py install for requests 10:57:54 INFO - Running setup.py install for docopt 10:57:54 INFO - Successfully installed blobuploader requests docopt 10:57:54 INFO - Cleaning up... 10:57:54 INFO - Return code: 0 10:57:54 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:57: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')]} 10:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57: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')]} 10:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:54 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 0x7f06f5302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb840>, '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 0x1e286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', '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 10:57:54 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 10:57:54 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 10:57:54 INFO - Using env: {'DISPLAY': ':0', 10:57:54 INFO - 'HOME': '/home/cltbld', 10:57:54 INFO - 'LANG': 'en_US.UTF-8', 10:57:54 INFO - 'LANGUAGE': 'en_US:en', 10:57:54 INFO - 'LOGNAME': 'cltbld', 10:57:54 INFO - 'MAIL': '/var/mail/cltbld', 10:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:54 INFO - 'MOZ_NO_REMOTE': '1', 10:57:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:54 INFO - 'NO_EM_RESTART': '1', 10:57:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:54 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:54 INFO - 'SHELL': '/bin/bash', 10:57:54 INFO - 'SHLVL': '1', 10:57:54 INFO - 'TERM': 'linux', 10:57:54 INFO - 'TMOUT': '86400', 10:57:54 INFO - 'USER': 'cltbld', 10:57:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', 10:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:54 INFO - '_': '/tools/buildbot/bin/python'} 10:57:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:57:54 INFO - Running setup.py (path:/tmp/pip-rJE0Ca-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:57:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:57:55 INFO - Running setup.py (path:/tmp/pip-6Elz5b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:57:55 INFO - Running setup.py (path:/tmp/pip-QvyAZo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:57:55 INFO - Running setup.py (path:/tmp/pip-SfEp4B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:57:55 INFO - Running setup.py (path:/tmp/pip-IcPulm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:57:55 INFO - Running setup.py (path:/tmp/pip-kuHExj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:57:55 INFO - Running setup.py (path:/tmp/pip-LScGtr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:57:55 INFO - Running setup.py (path:/tmp/pip-UFDOCh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:57:55 INFO - Running setup.py (path:/tmp/pip-bEiOXP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:57:55 INFO - Running setup.py (path:/tmp/pip-zw5Vnb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:57:55 INFO - Running setup.py (path:/tmp/pip-SgYBOH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:57:55 INFO - Running setup.py (path:/tmp/pip-khdq9K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:57:55 INFO - Running setup.py (path:/tmp/pip-SYStGW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:57:55 INFO - Running setup.py (path:/tmp/pip-nrPRDd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:57:55 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:57:55 INFO - Running setup.py (path:/tmp/pip-sX_s1H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:57:56 INFO - Running setup.py (path:/tmp/pip-ZWohPS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:57:56 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:57:56 INFO - Running setup.py (path:/tmp/pip-EAB5p_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:57:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:57:56 INFO - Running setup.py install for manifestparser 10:57:56 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 10:57:56 INFO - Running setup.py install for mozcrash 10:57:56 INFO - Running setup.py install for mozdebug 10:57:56 INFO - Running setup.py install for mozdevice 10:57:56 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 10:57:56 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 10:57:56 INFO - Running setup.py install for mozfile 10:57:56 INFO - Running setup.py install for mozhttpd 10:57:56 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 10:57:56 INFO - Running setup.py install for mozinfo 10:57:56 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 10:57:56 INFO - Running setup.py install for mozInstall 10:57:56 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 10:57:56 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 10:57:56 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 10:57:56 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 10:57:56 INFO - Running setup.py install for mozleak 10:57:57 INFO - Running setup.py install for mozlog 10:57:57 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 10:57:57 INFO - Running setup.py install for moznetwork 10:57:57 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 10:57:57 INFO - Running setup.py install for mozprocess 10:57:57 INFO - Running setup.py install for mozprofile 10:57:57 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 10:57:57 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 10:57:57 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 10:57:57 INFO - Running setup.py install for mozrunner 10:57:57 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 10:57:57 INFO - Running setup.py install for mozscreenshot 10:57:57 INFO - Running setup.py install for moztest 10:57:57 INFO - Running setup.py install for mozversion 10:57:57 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 10:57:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:57:57 INFO - Cleaning up... 10:57:57 INFO - Return code: 0 10:57:57 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f06f5302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb840>, '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 0x1e286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', '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 10:57:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 10:57:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:57:57 INFO - Using env: {'DISPLAY': ':0', 10:57:57 INFO - 'HOME': '/home/cltbld', 10:57:57 INFO - 'LANG': 'en_US.UTF-8', 10:57:57 INFO - 'LANGUAGE': 'en_US:en', 10:57:57 INFO - 'LOGNAME': 'cltbld', 10:57:57 INFO - 'MAIL': '/var/mail/cltbld', 10:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:57 INFO - 'MOZ_NO_REMOTE': '1', 10:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:57 INFO - 'NO_EM_RESTART': '1', 10:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:57:57 INFO - 'PWD': '/builds/slave/test-pgo', 10:57:57 INFO - 'SHELL': '/bin/bash', 10:57:57 INFO - 'SHLVL': '1', 10:57:57 INFO - 'TERM': 'linux', 10:57:57 INFO - 'TMOUT': '86400', 10:57:57 INFO - 'USER': 'cltbld', 10:57:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', 10:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:57 INFO - '_': '/tools/buildbot/bin/python'} 10:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:57:58 INFO - Running setup.py (path:/tmp/pip-wb5Jo_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 10:57:58 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)) 10:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:57:58 INFO - Running setup.py (path:/tmp/pip-x2rE6H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 10:57:58 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)) 10:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:57:58 INFO - Running setup.py (path:/tmp/pip-hP8gNr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 10:57:58 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)) 10:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:57:58 INFO - Running setup.py (path:/tmp/pip-aC_9kl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 10:57:58 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)) 10:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 10:57:58 INFO - Running setup.py (path:/tmp/pip-xL2MZ0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 10:57:58 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)) 10:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:57:58 INFO - Running setup.py (path:/tmp/pip-2ak4eJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 10:57:58 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)) 10:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:57:58 INFO - Running setup.py (path:/tmp/pip-FiVmtk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 10:57:58 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)) 10:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:57:58 INFO - Running setup.py (path:/tmp/pip-mnuXns-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 10:57:58 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)) 10:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 10:57:58 INFO - Running setup.py (path:/tmp/pip-XeHir6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 10:57:58 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)) 10:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 10:57:58 INFO - Running setup.py (path:/tmp/pip-CJqhhy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 10:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:57:58 INFO - Running setup.py (path:/tmp/pip-cFDABw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 10:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 10:57:58 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:57:58 INFO - Running setup.py (path:/tmp/pip-ZnaB5i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 10:57:59 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)) 10:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:57:59 INFO - Running setup.py (path:/tmp/pip-0fBGQm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 10:57:59 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)) 10:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:57:59 INFO - Running setup.py (path:/tmp/pip-ZNA8Bo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 10:57:59 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)) 10:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:57:59 INFO - Running setup.py (path:/tmp/pip-JMYsL6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 10:57:59 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)) 10:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 10:57:59 INFO - Running setup.py (path:/tmp/pip-uoQ3MY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 10:57:59 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)) 10:57:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 10:57:59 INFO - Running setup.py (path:/tmp/pip-ep10UD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 10:57:59 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)) 10:57:59 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)) 10:57:59 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)) 10:57:59 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)) 10:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 10:57:59 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)) 10:57:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:58:01 INFO - Downloading blessings-1.5.1.tar.gz 10:58:01 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 10:58:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 10:58:01 INFO - Installing collected packages: blessings 10:58:01 INFO - Running setup.py install for blessings 10:58:01 INFO - Successfully installed blessings 10:58:01 INFO - Cleaning up... 10:58:01 INFO - Return code: 0 10:58:01 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 10:58:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:58:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:58:01 INFO - Reading from file tmpfile_stdout 10:58:01 INFO - Current package versions: 10:58:01 INFO - argparse == 1.2.1 10:58:01 INFO - blessings == 1.5.1 10:58:01 INFO - blobuploader == 1.2.4 10:58:01 INFO - docopt == 0.6.1 10:58:01 INFO - manifestparser == 1.1 10:58:01 INFO - mozInstall == 1.12 10:58:01 INFO - mozcrash == 0.16 10:58:01 INFO - mozdebug == 0.1 10:58:01 INFO - mozdevice == 0.47 10:58:01 INFO - mozfile == 1.2 10:58:01 INFO - mozhttpd == 0.7 10:58:01 INFO - mozinfo == 0.9 10:58:01 INFO - mozleak == 0.1 10:58:01 INFO - mozlog == 3.1 10:58:01 INFO - moznetwork == 0.27 10:58:01 INFO - mozprocess == 0.22 10:58:01 INFO - mozprofile == 0.28 10:58:01 INFO - mozrunner == 6.11 10:58:01 INFO - mozscreenshot == 0.1 10:58:01 INFO - mozsystemmonitor == 0.0 10:58:01 INFO - moztest == 0.7 10:58:01 INFO - mozversion == 1.4 10:58:01 INFO - psutil == 3.1.1 10:58:01 INFO - requests == 1.2.3 10:58:01 INFO - wsgiref == 0.1.2 10:58:01 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 10:58:01 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')]} 10:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:01 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')]} 10:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:01 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 0x7f06f5302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb840>, '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 0x1e286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', '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 10:58:01 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 10:58:01 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 10:58:01 INFO - Using env: {'DISPLAY': ':0', 10:58:01 INFO - 'HOME': '/home/cltbld', 10:58:01 INFO - 'LANG': 'en_US.UTF-8', 10:58:01 INFO - 'LANGUAGE': 'en_US:en', 10:58:01 INFO - 'LOGNAME': 'cltbld', 10:58:01 INFO - 'MAIL': '/var/mail/cltbld', 10:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:01 INFO - 'MOZ_NO_REMOTE': '1', 10:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:01 INFO - 'NO_EM_RESTART': '1', 10:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:01 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:01 INFO - 'SHELL': '/bin/bash', 10:58:01 INFO - 'SHLVL': '1', 10:58:01 INFO - 'TERM': 'linux', 10:58:01 INFO - 'TMOUT': '86400', 10:58:01 INFO - 'USER': 'cltbld', 10:58:01 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', 10:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:01 INFO - '_': '/tools/buildbot/bin/python'} 10:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:01 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)) 10:58:01 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)) 10:58:01 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)) 10:58:01 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)) 10:58:01 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)) 10:58:01 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)) 10:58:01 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)) 10:58:01 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)) 10:58:01 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)) 10:58:01 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)) 10:58:01 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)) 10:58:01 INFO - Cleaning up... 10:58:01 INFO - Return code: 0 10:58:01 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 10:58:01 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')]} 10:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:01 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')]} 10:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:01 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 0x7f06f5302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb840>, '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 0x1e286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', '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 10:58:01 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 10:58:01 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 10:58:01 INFO - Using env: {'DISPLAY': ':0', 10:58:01 INFO - 'HOME': '/home/cltbld', 10:58:01 INFO - 'LANG': 'en_US.UTF-8', 10:58:01 INFO - 'LANGUAGE': 'en_US:en', 10:58:01 INFO - 'LOGNAME': 'cltbld', 10:58:01 INFO - 'MAIL': '/var/mail/cltbld', 10:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:01 INFO - 'MOZ_NO_REMOTE': '1', 10:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:01 INFO - 'NO_EM_RESTART': '1', 10:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:01 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:01 INFO - 'SHELL': '/bin/bash', 10:58:01 INFO - 'SHLVL': '1', 10:58:01 INFO - 'TERM': 'linux', 10:58:01 INFO - 'TMOUT': '86400', 10:58:01 INFO - 'USER': 'cltbld', 10:58:01 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', 10:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:01 INFO - '_': '/tools/buildbot/bin/python'} 10:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:01 INFO - Downloading/unpacking jsonschema 10:58: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 10:58: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 10:58: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 10:58: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 10:58: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 10:58: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 10:58:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:58:03 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 10:58:03 INFO - Downloading/unpacking functools32 (from jsonschema) 10:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:03 INFO - Downloading functools32-3.2.3-2.tar.gz 10:58:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:58:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 10:58:03 INFO - warning: no files found matching '*.txt' 10:58:03 INFO - no previously-included directories found matching 'build' 10:58:03 INFO - no previously-included directories found matching 'dist' 10:58:03 INFO - no previously-included directories found matching '.git*' 10:58:03 INFO - Installing collected packages: jsonschema, functools32 10:58:04 INFO - Running setup.py install for functools32 10:58:04 INFO - warning: no files found matching '*.txt' 10:58:04 INFO - no previously-included directories found matching 'build' 10:58:04 INFO - no previously-included directories found matching 'dist' 10:58:04 INFO - no previously-included directories found matching '.git*' 10:58:04 INFO - Successfully installed jsonschema functools32 10:58:04 INFO - Cleaning up... 10:58:04 INFO - Return code: 0 10:58:04 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 10:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:58:04 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 0x7f06f5302f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2a630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebb840>, '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 0x1e286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28b60>, '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': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', '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 10:58:04 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 10:58:04 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 10:58:04 INFO - Using env: {'DISPLAY': ':0', 10:58:04 INFO - 'HOME': '/home/cltbld', 10:58:04 INFO - 'LANG': 'en_US.UTF-8', 10:58:04 INFO - 'LANGUAGE': 'en_US:en', 10:58:04 INFO - 'LOGNAME': 'cltbld', 10:58:04 INFO - 'MAIL': '/var/mail/cltbld', 10:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:04 INFO - 'MOZ_NO_REMOTE': '1', 10:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:04 INFO - 'NO_EM_RESTART': '1', 10:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:04 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:04 INFO - 'SHELL': '/bin/bash', 10:58:04 INFO - 'SHLVL': '1', 10:58:04 INFO - 'TERM': 'linux', 10:58:04 INFO - 'TMOUT': '86400', 10:58:04 INFO - 'USER': 'cltbld', 10:58:04 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', 10:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:04 INFO - '_': '/tools/buildbot/bin/python'} 10:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:58:04 INFO - Downloading/unpacking flake8 10:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:58:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:58:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:58:06 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 10:58:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:58: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 10:58: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 10:58: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 10:58: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 10:58: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 10:58: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 10:58:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:58:06 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 10:58:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:58: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 10:58: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 10:58: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 10:58: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 10:58: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 10:58: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 10:58:06 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 10:58:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:58: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 10:58: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 10:58: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 10:58: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 10:58: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 10:58: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 10:58:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:58:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 10:58:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:58:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:58:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:58:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:58:06 INFO - no previously-included directories found matching 'docs/_build' 10:58:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:58:06 INFO - Running setup.py install for pep8 10:58:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:58:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:58:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:58:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:58:06 INFO - no previously-included directories found matching 'docs/_build' 10:58:06 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 10:58:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:58:06 INFO - Cleaning up... 10:58:06 INFO - Return code: 0 10:58:06 INFO - Running post-action listener: _resource_record_post_action 10:58:06 INFO - Running post-action listener: _start_resource_monitoring 10:58:06 INFO - Starting resource monitoring. 10:58:06 INFO - ##### 10:58:06 INFO - ##### Running install step. 10:58:06 INFO - ##### 10:58:06 INFO - Running pre-action listener: _resource_record_pre_action 10:58:06 INFO - Running main action method: install 10:58:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 10:58:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 10:58:07 INFO - Reading from file tmpfile_stdout 10:58:07 INFO - Detecting whether we're running mozinstall >=1.0... 10:58:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 10:58:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 10:58:07 INFO - Reading from file tmpfile_stdout 10:58:07 INFO - Output received: 10:58:07 INFO - Usage: mozinstall [options] installer 10:58:07 INFO - Options: 10:58:07 INFO - -h, --help show this help message and exit 10:58:07 INFO - -d DEST, --destination=DEST 10:58:07 INFO - Directory to install application into. [default: 10:58:07 INFO - "/builds/slave/test-pgo"] 10:58:07 INFO - --app=APP Application being installed. [default: firefox] 10:58:07 INFO - mkdir: /builds/slave/test-pgo/build/application 10:58:07 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'] 10:58:07 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 10:58:23 INFO - Reading from file tmpfile_stdout 10:58:23 INFO - Output received: 10:58:23 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 10:58:23 INFO - Running post-action listener: _resource_record_post_action 10:58:23 INFO - ##### 10:58:23 INFO - ##### Running run-tests step. 10:58:23 INFO - ##### 10:58:23 INFO - Running pre-action listener: _resource_record_pre_action 10:58:23 INFO - Running main action method: run_tests 10:58:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 10:58:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 10:58:23 INFO - Python 2.7.3 10:58:23 INFO - Return code: 0 10:58:23 INFO - grabbing minidump binary from tooltool 10:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:58:23 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 0x1ebb840>, '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 0x1e286b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e28b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 10:58:23 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 10:58:23 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 10:58:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:58:23 INFO - Return code: 0 10:58:23 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 10:58:23 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 10:58:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 10:58:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 10:58:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 10:58:23 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 10:58:23 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 10:58:24 INFO - Return code: 0 10:58:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 10:58:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 10:58:24 INFO - Using env: {'DISPLAY': ':0', 10:58:24 INFO - 'HOME': '/home/cltbld', 10:58:24 INFO - 'LANG': 'en_US.UTF-8', 10:58:24 INFO - 'LANGUAGE': 'en_US:en', 10:58:24 INFO - 'LOGNAME': 'cltbld', 10:58:24 INFO - 'MAIL': '/var/mail/cltbld', 10:58:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:58:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 10:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:58:24 INFO - 'MOZ_NO_REMOTE': '1', 10:58:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 10:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:58:24 INFO - 'NO_EM_RESTART': '1', 10:58:24 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 10:58:24 INFO - 'PWD': '/builds/slave/test-pgo', 10:58:24 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 10:58:24 INFO - 'SHELL': '/bin/bash', 10:58:24 INFO - 'SHLVL': '1', 10:58:24 INFO - 'TERM': 'linux', 10:58:24 INFO - 'TMOUT': '86400', 10:58:24 INFO - 'USER': 'cltbld', 10:58:24 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562', 10:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:58:24 INFO - '_': '/tools/buildbot/bin/python'} 10:58:24 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:58:24 INFO - mozversion application_buildid: 20160108083159 10:58:24 INFO - mozversion application_changeset: be73ca2ad9b5a49d5ca22b870538a683cdc13379 10:58:24 INFO - mozversion application_display_name: Nightly 10:58:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:58:24 INFO - mozversion application_name: Firefox 10:58:24 INFO - mozversion application_remotingname: firefox 10:58:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 10:58:24 INFO - mozversion application_vendor: Mozilla 10:58:24 INFO - mozversion application_version: 46.0a1 10:58:24 INFO - mozversion platform_buildid: 20160108083159 10:58:24 INFO - mozversion platform_changeset: be73ca2ad9b5a49d5ca22b870538a683cdc13379 10:58:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 10:58:24 INFO - mozversion platform_version: 46.0a1 10:58:24 INFO - using testdate: 1452279504 10:58:24 INFO - actual date: 1452279504 10:58:24 INFO - starting webserver on 'localhost:42633' 10:58:24 INFO - SUITE-START | Running 3 tests 10:58:24 INFO - TEST-START | dromaeo_css 10:58:24 INFO - operating with platform_type : linux_ 10:58:24 INFO - Initialising browser for dromaeo_css test... 10:58:24 INFO - TEST-INFO | started process 3300 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCxtxME/profile http://localhost:42633/getInfo.html) 10:58:32 INFO - PROCESS | 3300 | __metrics Screen width/height:1600/1200 10:58:32 INFO - PROCESS | 3300 | colorDepth:24 10:58:32 INFO - PROCESS | 3300 | Browser inner width/height: 1024/697 10:58:32 INFO - PROCESS | 3300 | __metrics 10:58:32 INFO - PROCESS | 3300 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:58:32 INFO - PROCESS | 3300 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:58:33 INFO - TEST-INFO | 3300: exit 0 10:58:33 INFO - Browser initialized. 10:58:33 INFO - Running cycle 1/1 for dromaeo_css test... 10:58:33 INFO - TEST-INFO | started process 3393 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpCxtxME/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:58:45 INFO - PROCESS | 3393 | RSS: Main: 149274624 10:58:45 INFO - PROCESS | 3393 | 10:59:36 INFO - PROCESS | 3393 | 1452279576619 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] 11:01:45 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:42633/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42633/tests/dromaeo/cssquery-ext.html) 11:01:46 INFO - PROCESS | 3393 | RSS: Main: 271884288 11:01:46 INFO - PROCESS | 3393 | 11:04:49 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:42633/tests/dromaeo/cssquery-ext.html (next: http://localhost:42633/tests/dromaeo/cssquery-jquery.html) 11:04:49 INFO - PROCESS | 3393 | RSS: Main: 232087552 11:04:49 INFO - PROCESS | 3393 | 11:07:51 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:42633/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42633/tests/dromaeo/cssquery-mootools.html) 11:07:52 INFO - PROCESS | 3393 | RSS: Main: 230379520 11:07:52 INFO - PROCESS | 3393 | 11:10:54 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:42633/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42633/tests/dromaeo/cssquery-prototype.html) 11:10:54 INFO - PROCESS | 3393 | RSS: Main: 211042304 11:10:54 INFO - PROCESS | 3393 | 11:13:57 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:42633/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42633/tests/dromaeo/cssquery-yui.html) 11:13:57 INFO - PROCESS | 3393 | RSS: Main: 220409856 11:13:57 INFO - PROCESS | 3393 | 11:17:00 INFO - PROCESS | 3393 | Cycle 1(1): loaded http://localhost:42633/tests/dromaeo/cssquery-yui.html (next: http://localhost:42633/tests/dromaeo/cssquery-dojo.html) 11:17:00 INFO - PROCESS | 3393 | RSS: Main: 307417088 11:17:00 INFO - PROCESS | 3393 | 11:17:00 INFO - PROCESS | 3393 | __start_tp_report 11:17:00 INFO - PROCESS | 3393 | _x_x_mozilla_page_load 11:17:00 INFO - PROCESS | 3393 | _x_x_mozilla_page_load_details 11:17:00 INFO - PROCESS | 3393 | |i|pagename|runs| 11:17:00 INFO - PROCESS | 3393 | |0;dojo.html;3030.2272920405294;3066.5246886732566;3105.6739042400545;3111.626604807422;3121.5629811826343;4882.218844984804;4980.178270585349;5043.697378157313;5066.265391518227;5076.010178015288;4925.458199598051;4985.750712464372;5003.774830132644;5012.423571289303;5021.422536408314;4360.062586543892;4537.523560026199;4580.410045367771;4667.043256132485;4672.64955128365;4528.298113792367;4583.495815460296;4628.30575413689;4634.930476042862;4703.5061318561575;4487.282034874404;4598.402207713009;4602.792874320664;4622.375979242793;4657.11514812188;4582.427196600425;4593.678442509025;4593.701409408378;4600.102979918917;4620.953790462119;4483.327500874862;4544.386507821435;4554.339620755005;4569.565891240327;4606.792694328729;4864.391951006124;4868.829590964335;4970.676906001098;4977.90044199114;5007.048660754445;5405.891882162335;5417.729113544347;5422.0511410503395;5424.349078110613;5476.945230547723;5287.709175995319;5398.6220964532495;5438.129899216146;5439.347278326587;5443;4998.90002199954;5050.292958985745;5067.189249720027;5071.188609822448;5113.2330150477355;5536.695481748542;5544.417836127229;5551.8889622208135;5597.216389705444;5605.383407825136;5161.74191290434;5237.6333656643665;5266.578673706171;5288.735563221823;5312.362516498045;5367.275417818622;5418.512333889968;5420.945790542123;5421.295231619864;5467.043267428264;5315.468453154654;5366.221897824794;5370.4629537045985;5378.300820893259;5407.810726624628;5268.710220937885;5310.973445132827;5355.866103347447;5372.140457526777;5383.16560933056;4252.659787217015;4271.209826182167;4275.615194632498;4296.419983302277;4313.288307429302;3787.223619158066;3823.9617603824163;3831.2146010068427;3853.3641949078087;3865.3042452358845;5031.874203144877;5142.1772516397195;5143.974280128576;5188.247704082887;5205.791768329224;5377.623566350396;5443.074677304868;5443.836684899459;5470.152126420411;5509.779608815603;5174.534291913746;5194.0910340690225;5196.376434827845;5200.2199670049795;5251.868703282448;4583.060472603109;4679.719216847;4682.555157260055;4708.458527269339;4709.576138147583;5686.118651609007;5770.682612456355;5775.220345253421;5775.451332123525;5821;5349.491798279158;5357.410684824744;5368.597355198453;5368.812091576776;5385.973070134624;5559.33288005442;5591.944080559142;5647.6893770843;5654.7455364509515;5668.404817494104;5266.605004624746;5314.335708036496;5361.731913404392;5366.892662146814;5371.543418809445;5370.248165256789;5378.569714422915;5408.75660595282;5415.891682166256;5418.997485465202;5127.41034781005;5265.447128051499;5284.418713941386;5286.36563612369;5332.840014799563;5107.489251074863;5225.3990791057995;5242.030224408497;5243.344581927259;5289.2330612061805;5137.537621614073;5151.150060240018;5154.098032844312;5154.639175257696;5203.16749320107;5154.819581314636;5240.4759524047295;5245.0821106307;5250.448702886295;5267.341582302212;5036.395632524121;5101.872453188552;5133.820316289061;5183.041137389595;5190.97404512975 11:17:00 INFO - PROCESS | 3393 | |1;ext.html;535.7241020874251;551.5504863536217;561.8341940473517;572.0332637842049;586.2876604925016;28115.15654530365;28832.279193020186;28834.134975950703;28867.13398598043;35724.82137589309;38577.61422385775;39042.21915561687;39049.609503904954;39098.8045059775;39147.99999999993;8352.791180220498;8559;8562.315014798802;8617.439866408695;8628.65485380584;7472.4395670324675;7668.07983042033;8282.668693252263;8405.873911891327;9879.555420006118;10025.34835235711;10027.298089133763;10110;10122.595096196143;10132.645357412492;9887.604495820158;9990.150837178848;9995.250831104564;9999.450030248334;9999.700008999742;7464.141623713288;7648.694052237904;9985.20118390527;10321.43232122233;10321.43232122233;35703.821480892686;36354.45468317977;36378.63621363779;36387;36391.81804090989;3105.099521138867;3128.702773236539;3149.6377916539664;3170.4927211646254;3266.2324353776844;25651.658473916366;25793.74206257932;26186.214413567624;26318.73681263182;26353;3473.166440054394;3499.61504234534;3539.29214157167;3594.2991116732246;3654.086478380405;272587;272713;272783;272807;274811;52274.738626307386;53207.46792532103;53809.1928621071;53870.730646346514;53937.46062539403;64603.67698161479;65159;65458;65503.67248163729;65660;14183.503577374742;14190.361433735507;14196.858031419553;14326.355314010894;14341.713165736626;9665.178459830853;9895.901040989642;11947.880521194676;12163.452644630835;12424.56514022005;19444.416667499714;19519.219231230876;19659.60680786376;19695.60608787816;20330.59338813245;7390.22402647725;7643.235676432423;7646.235376462309;7755.0224692703;7773.950516680289;869.3262721390972;906.2659246010752;954.0793134624981;1044.4151275285865;1046.2571574182416;28219.57670634942;28500.572491412644;28728.425431491254;28946.27634309117;29039.56440653392;1033.705393962717;1067.9412632305143;1097.5774326884048;1106.5186643809968;1134.852469179018;14886.851131488764;15365;15381.307841147176;15411.61470963235;15642.530724078295;323731;326895;327072;327867;328483;45230.547694523295;52696.73651631794;52947.47052529425;52952.70472952751;52965.7351713239;1333.4266265505926;1346.2461021827612;1356.6404902700792;1358.952436664712;1359.5037811199038;25945.22164335073;25982.480350393264;27822.721772782013;28453.43093138167;28553.571696424155;39776.80111599423;40597.594024059385;43316;44428.55571444244;48256.10463372209;237486;239477;239796;241122;241602;32301.192470188435;32625.836870815496;32683.346333072728;32698.83650581732;32750.50874236936;42235;42744.572554275306;43286.56713432951;43597.47408840675;44449.55550444584;35304.64695353116;36096.4585531212;36480.270394591425;36552.45171322486;37191.44212836864;32950.50574241436;33322.333553329285;33723.66276337205;33899.66100338965;34247.143821404665;34777.13057173591;35462.46806297959;35471;35548.28903421865;35737.64262357447;30531.389372212874;31501.36997259996;32001.839990799897;32024.67975320217;32056.198595034377;24576.262712118663;24777.504449911263;24815.379615509755;25019.74980250174;25149.497010060062 11:17:00 INFO - PROCESS | 3393 | |2;jquery.html;354.9378858699727;356.532867251261;357.53877498027543;357.5494876455665;357.662009401116;12954.35228238589;13363;15643.687126257468;15832.287547060381;16318.673626527463;14506.637334066654;14679.486217982372;16182.919085404557;16372.83627163728;16391.18044097796;5101.974490127563;5276.630635855492;5378.46215378461;5385.380681221671;5390.460953904598;3923.9215215695667;4019.477467929165;5265.262863199156;5596.104623260258;5822.621529600562;5668.186180422266;5713.257276554063;5730.742116604742;5777.45114214149;5780.739866706008;5764.481196692297;5805.622634528742;5820.3597604263705;5821.3596504384695;5823.097419899922;5055.140626093573;5124.205748109049;5217.113090774577;5222.92165617516;5225.425203227642;19223.807761922482;19259;19523.707144392847;19548.12033458498;19585.412437626896;1970.6649869522073;2068.2225498811063;2115.101082040142;2238.787315205053;2325.03511042917;10621.787564248749;12333.197741906677;12356;12448.439820208112;12941.417636206299;1766.0904634113442;1777.3423833181675;1797.6854050541233;1818.6817306971227;1819.9090045497671;53090.46909530894;53939.46060539383;54321.456785432034;54908;55231.72384138094;9384.718458446258;9419.858702119336;9432.717018489457;9476.478793666414;9505;12076.637700868989;12088.758224835454;12144.939275303566;12169.452374643162;12196.512139514498;6669.532702805375;6807.081044059088;6830.975353696886;7010.894836577456;7072.328128827753;6735.393814556714;6798.932010679929;6804.795856124324;6828.658567071627;6856.554323969026;3593.802340871277;4064.9796751016056;4097.8975525612095;4101.507819061731;4139.751614903115;1575.2045217165257;1590.745480723102;1676.555712736126;1677.6057626458016;1685.3231035119888;404.7348986413904;894.8031433084711;940.4639355567398;941.9576119074658;970.3062310447923;9106.31702622306;9402.529873506297;9948.751281218027;10448.164146868232;10957.56169753201;426.2327809942092;429.3623968406913;438.3687490014369;445;448.95959363657425;4883.658143929962;5790.536757059509;5902.3507414184405;5914.349421563625;5947.5539334550085;512242;525661;534406;534696;535319;70015;71362;71743.77153028126;72800.63599681968;73512;472.8983268597268;480.9278608208797;482.55845901000896;483.6227742360964;485.5144855144855;9813.411195328303;9891.554880030271;10043.799124017625;10100.797984040424;10244.385336879812;29372.11883643494;31951.680483194872;33169.83415082909;33625.15937101592;33959;35740.82129589439;35801.46297805483;36000.27999440049;37298;38141.427878581286;6868.244493105654;7225.747098851515;7270.890936635848;7299.379552738077;7329.6701648427015;9691.903080969381;10519.105876000625;10755.946220268848;11169.72075698114;11448.713782155513;9585.856212156683;9624.951875240578;9818.312718109664;9926.759155105612;10324.793504130026;7459.552426854406;9441;9844.704658860246;9861.211103111591;10066.597336106473;9314.48770317639;9554.522273886418;9753.804923901624;9939.801203975736;9951.651692190739;7258.854822903407;7260.16508101554;7286.526375785557;7296.7081316746735;7323.523970941872;9369.484678342484;9865.112139907444;9905.801883962424;9967.40195588267;10032.799344013225 11:17:00 INFO - PROCESS | 3393 | |3;mootools.html;1328.9136206146593;1466.2668665667165;1482.1996122094074;1638.524827799938;1790.579213884736;7054.929450705491;7697.961510192448;7810.687572497093;7814.960925195373;7891.4081443891655;7651.426143039281;7797;7797.791342341932;7844.882326765103;7856.8035799105055;1907.551725344543;1956.0513151121695;2202.405350555357;2224.855384400013;2273.624851899435;2233.8436309458343;2239.3729755668437;2242.0471299697565;2243.618584840581;2244.16965722682;2166.2526428382184;2262.8076613487874;2263.818894488445;2264.535770167112;2264.682944387787;2196.3081629286726;2233.274185889576;2235.3182279404773;2255.6842042114035;2262.4457008032973;2168.6313326734494;2169.034779523113;2184.14818220894;2192.967105493419;2251.4371407148215;7889.408294377888;7945.64244608994;7949.96025019877;7993.160718124572;7998.4001199910235;4630;4715.811367545329;4747.810087596492;4751;4760.571548560646;2895.8552072396506;3019.139545229599;3030.4090702313056;3037.893673721409;3045.6040714706946;947.161761840769;950.5199874063622;967.3663750243531;993.1062044160313;1004.0912973758687;10695.893041069645;10726.678199654023;10728.785424291471;10741.462926853626;10800.5679772809;3851.287511810324;3925.823337949799;3967.7619342838943;4043.8786836394956;4047.0489434982755;8916.73249802494;9129.589168487433;9154.954225228832;9190.448573085636;9203;4613.30800379939;4630.560096790799;4636.629069674418;4663.860084197479;4665.393498845128;4206.978965105155;4237.491501019897;4238.618524332825;4248.681348898845;4249.532551419341;3317.5023746437746;3360.7479439042168;3454.4818277258614;3598.3522965866396;3698.7595806272507;1102.9117670586495;1105.8894110589038;1106.9280496767685;1107.789519991199;1108.9944550277196;1145.9025982791388;1299.5191779041816;1325.4168166006925;1355.5120156743565;1365.49476693624;7470.140933792683;7533.54798712079;7631.3513351364645;7684.538927664358;7692.076950765944;1114.4260705736551;1135.982960255597;1140.1790710688292;1142.348861149137;1148.5463242019355;5648.790432858408;5945.0785128304315;5948.970255148696;5974.761009559656;5983.311919129356;9541.284403669753;9565.091316325077;9784.510774461249;9790;9798.510074496247;9641.951790241144;9704.854427183598;9716.61133554664;9722.125008749246;9729.70810875675;6911.17065952089;7168.2831716827895;7256.7097316106765;7260.346568808727;7282.96358518204;7274.454415918722;7340.1191856975365;7348.889766653398;7354.485186036926;7365.116186057493;8452.366072544706;8535.189157030072;8570.4000719949;8595.570221489026;8814.735557933273;8662.263707584925;8888.955555222183;8964.820703586021;9106;9114.225290850352;6806.285340039224;6816.284290149463;6927.930720692729;6930.306969303029;6987.1266091738535;6725.39471447572;6874.450043996569;7287.672054757442;7604.5437273763755;7616.7334143304715;6871.244163141951;6920;6992.79021629352;7017.754378596725;7208.06295181644;6697.2633010367845;6861.897071544031;6900.516963812485;6944.062551555678;6997.335253150943;7022.719091236498;7066.964665176642;7067.045948797052;7090.539114957512;7099.609521476368;6216.285127210248;6458.580192287486;6495.285518593046;6526;6541.542092053701;6642.867142657024;6671.199456065109;6671.46628269747;6713.798586042427;6742.157230346207 11:17:00 INFO - PROCESS | 3393 | |4;prototype.html;310.4954449020342;318.9314297426053;330.3821853134639;330.63464871317194;333.7346809286616;5575.609707320479;5750.338711048231;5759.74081166348;5761.539076873851;5761.913571296429;5562.249096371988;5637.774489020434;5641.12562552804;5646.915296270549;5673.574481913863;4449.5995360417555;4454;4454.53227411122;4454.97772511137;4460.1525710114975;4251.149770045988;4350;4366.67249956253;4426.468823741156;4431.778411079449;4381.38660587518;4384.780760961955;4386.583274588925;4389.231884420214;4398.252297109483;4381.715188512769;4384.12317536494;4385.298352263622;4394.7143435676735;4400.977995110036;3910;3913.8238779255003;3914.6868250539887;3919.686425086015;3924.548676902136;5322.414534401213;5420.728963551846;5432.619716619838;5437.456254374571;5453.83638490842;5149.48505149482;5152.690838549662;5158.432572417031;5163.7676304566385;5166.225066240057;5973.581849270553;6028.457438830526;6030.517558595302;6033.306169790487;6033.668148251844;4145.958540414587;4201.516825565038;4244.808983595714;4291.399204111427;4304.5910638489295;6193.009118541012;6207.31719510858;6208.1308616793685;6212.192414986068;6215.627062376272;4392.934105988413;4411.779411029435;4419.226635338867;4419.9779001105435;4421.955780442218;4279.144171165779;4472.619827314649;4475.910481790346;4483.708558943658;4485.618722408566;4971.900561988812;4984.975075124601;4985.900281994413;4989.101961646938;4990.326305948651;5966.761329546856;5970.9701451492465;5975.372585878507;5975.760969561169;5979.910301345483;1589.6741168060519;1610.3961014619517;1610.7261765499893;1611.3151910438016;1611.7582362645696;1069.775347177086;1087.5595383869545;1096.1395304685784;1101.1411099342527;1103.2056919018294;5858.648481091148;5861.062230043172;5862.8534286642325;5867.14926335679;5876.706164691748;6170.5372097092895;6185.567010309325;6195.597286176384;6200.751969921243;6228.813135605939;5826.951148793258;5876.118582212703;5877.441643043904;5884.205632239593;5885.852853678607;3281.5241789940324;3359.9664003360144;3370.2753907909428;3373.2578832656777;3379.4761811919193;6619.966900165468;6625.204975402886;6632.90050649231;6634.966825165843;6635.435987940982;6414.422701956846;6420.5184611154355;6421.839454013593;6427.421532062043;6434.646094464756;6466.094746735461;6597.175353080865;6620.404163625297;6622.86754264912;6623.999999999904;6142.078688196806;6204.906926396198;6214.658193799384;6218.5647004709235;6222.719977600928;5969.791057312973;6107.755689772537;6110.7250173741395;6149.692515374124;6175.5677102602385;6512.34876512345;6630.635315057718;6637.402633762985;6655.833604159935;6666;4457.465104187519;4463.977680111579;4465.821367145278;4467.061916997467;4482.305242687388;6142.491459078335;6266.122742815918;6281;6284.528660350584;6285.402886725754;6082.148499210026;6133.662648554194;6133.938660613337;6142.9864072427545;6146.6004709693725;6137.202163718866;6138.416850399205;6140.4473597376455;6141.508679305734;6142.508599311955;5930.28836539618;6011.128386383863;6022.36765139654;6032.8793424132145;6044.123602077586;6106.1451396803595;6155.938440615716;6157.353477884758;6168.25980882297;6170.6914654268;5985.521158307412;6023.849403764941;6028.15605815195;6030.185924900258;6033 11:17:00 INFO - PROCESS | 3393 | |5;yui.html;810.7689308547064;811.5130921447129;814.385139219889;816.779469543223;826.256369267659;11819.468123934423;12048.518059277618;12129.393530323492;12140.210886292385;12144.453499592517;11528.596499122532;11545.942270288637;11573.710657233574;11582.942085289562;11583.247088939233;757.7878194105659;774.3959711425098;774.6126936531734;774.6591499740124;775.2983549887333;642.7846671365074;647.8833809914214;650.72344253692;756.1757684124303;765.1353970013877;791.9722809701661;799.4284086877881;799.9280064794167;800.1198681450417;800.3317230112863;790.4861839804116;792.4611264340247;792.7661339904741;793.1830214878655;796.9362451003934;492.2591499792789;499.3059647090547;585.5637550025258;591.1015256809668;591.8875413671389;11279.43602819864;11294;11296;11331.206815522917;11331.32012079278;12242.632721018384;12648.430820613003;12710.428030738547;12861.87138128616;12900.79252829922;10490.160787137087;10516;10557.313774604703;10624.309419887682;10737;3462.0998540379433;3532.8056956867363;3622.2031153146268;3622.2574372253625;3622.3660859349507;43158;43514.56485435137;43907;44988.77505612451;45189.77405112986;9708.90291097094;9858.162056225301;9879.776217116912;9974.351667141613;10115.291929564859;15588.220588970506;15876;15921.363145474283;15924.76112858308;16230.350785968665;7242.203357630657;7363.705451781869;7386.409087273005;7526.548407095483;7581.848363032708;4227.704060715781;4281.293586558183;4344.066025804467;4399;4450.198964186413;2842.474142283643;2870.7129287071125;2878.0502434196665;2879.4385094906293;2898.2899189698237;551.7075949746641;555.5916401444935;560.4115678537601;564.7599770097692;569.4191924237255;583.8744669895992;630.1052505442283;680.2347359220877;695.8990946312756;702.1574111066741;8471.745847624581;8897.421667591716;8935;9120.908790912139;9483.715488535356;573.5698226330252;613.9631622102688;666.2271764752863;682.3654001778294;704.9330313620197;3901.668358189586;4077.571854955187;4118.897027574275;4127.834886604563;4184.225918205142;50940.74529627402;51076.48923510792;51303.486965130614;51383.486165138616;51386.22920656193;25629.796275465567;25846.353841153745;25888.223353299432;49214.753926230136;49844.50155498471;42555.57444425516;43480.782596086814;43668.781656091516;43672;43782.781086095005;8559.186877246651;8762.956185219033;8766.123387661182;8851.380403371702;8923.73228803137;32675.18312042123;32766.853160139282;34089.659103408645;34614.13464663403;36287.81856090703;41133.58866411417;41350.1729965405;41778.37332439955;41820.79089604533;41985;10326.407145014307;10575.576976920836;10701.411422371844;10759.838602421127;10950.342979420942;12201.572944946884;12370.44333005035;12426.502939882303;12753.362331883554;12803.935980320039;10863.402512861869;11040.116790656888;11155.386453745123;11175.72060698489;11532.675246782457;11403.600873969372;11726.472308746297;11735;12141.39293035327;12144.392780361124;11310.830337545109;11630.534778609099;11723.765524689288;11817.290962542274;11943.402829858298;8998.460092394478;9624.326297159132;9779.168770654574;9969.850452243078;9979.401235925867;8328.875066873881;8745.518996455256;8781.692640757543;9203.217726493323;9570.760730981781 11:17:00 INFO - PROCESS | 3393 | __end_tp_report 11:17:00 INFO - PROCESS | 3393 | __start_cc_report 11:17:00 INFO - PROCESS | 3393 | _x_x_mozilla_cycle_collect,964 11:17:00 INFO - PROCESS | 3393 | __end_cc_report 11:17:00 INFO - PROCESS | 3393 | __startTimestamp1452280620496__endTimestamp 11:17:00 INFO - PROCESS | 3393 | 11:17:00 INFO - PROCESS | 3393 | ------- Summary: start ------- 11:17:00 INFO - PROCESS | 3393 | Number of tests: 6 11:17:00 INFO - PROCESS | 3393 | 11:17:00 INFO - PROCESS | 3393 | [#0] dojo.html Cycles:165 Average:5025.98 Median:5190.97 stddev:540.58 (10.4%) stddev-sans-first:519.07 11:17:00 INFO - PROCESS | 3393 | Values: 3030.2 3066.5 3105.7 3111.6 3121.6 4882.2 4980.2 5043.7 5066.3 5076.0 4925.5 4985.8 5003.8 5012.4 5021.4 4360.1 4537.5 4580.4 4667.0 4672.6 4528.3 4583.5 4628.3 4634.9 4703.5 4487.3 4598.4 4602.8 4622.4 4657.1 4582.4 4593.7 4593.7 4600.1 4621.0 4483.3 4544.4 4554.3 4569.6 4606.8 4864.4 4868.8 4970.7 4977.9 5007.0 5405.9 5417.7 5422.1 5424.3 5476.9 5287.7 5398.6 5438.1 5439.3 5443.0 4998.9 5050.3 5067.2 5071.2 5113.2 5536.7 5544.4 5551.9 5597.2 5605.4 5161.7 5237.6 5266.6 5288.7 5312.4 5367.3 5418.5 5420.9 5421.3 5467.0 5315.5 5366.2 5370.5 5378.3 5407.8 5268.7 5311.0 5355.9 5372.1 5383.2 4252.7 4271.2 4275.6 4296.4 4313.3 3787.2 3824.0 3831.2 3853.4 3865.3 5031.9 5142.2 5144.0 5188.2 5205.8 5377.6 5443.1 5443.8 5470.2 5509.8 5174.5 5194.1 5196.4 5200.2 5251.9 4583.1 4679.7 4682.6 4708.5 4709.6 5686.1 5770.7 5775.2 5775.5 5821.0 5349.5 5357.4 5368.6 5368.8 5386.0 5559.3 5591.9 5647.7 5654.7 5668.4 5266.6 5314.3 5361.7 5366.9 5371.5 5370.2 5378.6 5408.8 5415.9 5419.0 5127.4 5265.4 5284.4 5286.4 5332.8 5107.5 5225.4 5242.0 5243.3 5289.2 5137.5 5151.2 5154.1 5154.6 5203.2 5154.8 5240.5 5245.1 5250.4 5267.3 5036.4 5101.9 5133.8 5183.0 5191.0 11:17:00 INFO - PROCESS | 3393 | 11:17:00 INFO - PROCESS | 3393 | [#1] ext.html Cycles:180 Average:44534.56 Median:180716.75 stddev:73791.37 (40.8%) stddev-sans-first:73924.43 11:17:00 INFO - PROCESS | 3393 | Values: 535.7 551.6 561.8 572.0 586.3 28115.2 28832.3 28834.1 28867.1 35724.8 38577.6 39042.2 39049.6 39098.8 39148.0 8352.8 8559.0 8562.3 8617.4 8628.7 7472.4 7668.1 8282.7 8405.9 9879.6 10025.3 10027.3 10110.0 10122.6 10132.6 9887.6 9990.2 9995.3 9999.5 9999.7 7464.1 7648.7 9985.2 10321.4 10321.4 35703.8 36354.5 36378.6 36387.0 36391.8 3105.1 3128.7 3149.6 3170.5 3266.2 25651.7 25793.7 26186.2 26318.7 26353.0 3473.2 3499.6 3539.3 3594.3 3654.1 272587.0 272713.0 272783.0 272807.0 274811.0 52274.7 53207.5 53809.2 53870.7 53937.5 64603.7 65159.0 65458.0 65503.7 65660.0 14183.5 14190.4 14196.9 14326.4 14341.7 9665.2 9895.9 11947.9 12163.5 12424.6 19444.4 19519.2 19659.6 19695.6 20330.6 7390.2 7643.2 7646.2 7755.0 7774.0 869.3 906.3 954.1 1044.4 1046.3 28219.6 28500.6 28728.4 28946.3 29039.6 1033.7 1067.9 1097.6 1106.5 1134.9 14886.9 15365.0 15381.3 15411.6 15642.5 323731.0 326895.0 327072.0 327867.0 328483.0 45230.5 52696.7 52947.5 52952.7 52965.7 1333.4 1346.2 1356.6 1359.0 1359.5 25945.2 25982.5 27822.7 28453.4 28553.6 39776.8 40597.6 43316.0 44428.6 48256.1 237486.0 239477.0 239796.0 241122.0 241602.0 32301.2 32625.8 32683.3 32698.8 32750.5 42235.0 42744.6 43286.6 43597.5 44449.6 35304.6 36096.5 36480.3 36552.5 37191.4 32950.5 33322.3 33723.7 33899.7 34247.1 34777.1 35462.5 35471.0 35548.3 35737.6 30531.4 31501.4 32001.8 32024.7 32056.2 24576.3 24777.5 24815.4 25019.7 25149.5 11:17:00 INFO - PROCESS | 3393 | 11:17:00 INFO - PROCESS | 3393 | [#2] jquery.html Cycles:180 Average:26365.86 Median:5220.02 stddev:86386.97 (1654.9%) stddev-sans-first:86607.23 11:17:00 INFO - PROCESS | 3393 | Values: 354.9 356.5 357.5 357.5 357.7 12954.4 13363.0 15643.7 15832.3 16318.7 14506.6 14679.5 16182.9 16372.8 16391.2 5102.0 5276.6 5378.5 5385.4 5390.5 3923.9 4019.5 5265.3 5596.1 5822.6 5668.2 5713.3 5730.7 5777.5 5780.7 5764.5 5805.6 5820.4 5821.4 5823.1 5055.1 5124.2 5217.1 5222.9 5225.4 19223.8 19259.0 19523.7 19548.1 19585.4 1970.7 2068.2 2115.1 2238.8 2325.0 10621.8 12333.2 12356.0 12448.4 12941.4 1766.1 1777.3 1797.7 1818.7 1819.9 53090.5 53939.5 54321.5 54908.0 55231.7 9384.7 9419.9 9432.7 9476.5 9505.0 12076.6 12088.8 12144.9 12169.5 12196.5 6669.5 6807.1 6831.0 7010.9 7072.3 6735.4 6798.9 6804.8 6828.7 6856.6 3593.8 4065.0 4097.9 4101.5 4139.8 1575.2 1590.7 1676.6 1677.6 1685.3 404.7 894.8 940.5 942.0 970.3 9106.3 9402.5 9948.8 10448.2 10957.6 426.2 429.4 438.4 445.0 449.0 4883.7 5790.5 5902.4 5914.3 5947.6 512242.0 525661.0 534406.0 534696.0 535319.0 70015.0 71362.0 71743.8 72800.6 73512.0 472.9 480.9 482.6 483.6 485.5 9813.4 9891.6 10043.8 10100.8 10244.4 29372.1 31951.7 33169.8 33625.2 33959.0 35740.8 35801.5 36000.3 37298.0 38141.4 6868.2 7225.7 7270.9 7299.4 7329.7 9691.9 10519.1 10755.9 11169.7 11448.7 9585.9 9625.0 9818.3 9926.8 10324.8 7459.6 9441.0 9844.7 9861.2 10066.6 9314.5 9554.5 9753.8 9939.8 9951.7 7258.9 7260.2 7286.5 7296.7 7323.5 9369.5 9865.1 9905.8 9967.4 10032.8 11:17:00 INFO - PROCESS | 3393 | 11:17:00 INFO - PROCESS | 3393 | [#3] mootools.html Cycles:180 Average:5487.64 Median:6592.20 stddev:2896.11 (43.9%) stddev-sans-first:2887.36 11:17:00 INFO - PROCESS | 3393 | Values: 1328.9 1466.3 1482.2 1638.5 1790.6 7054.9 7698.0 7810.7 7815.0 7891.4 7651.4 7797.0 7797.8 7844.9 7856.8 1907.6 1956.1 2202.4 2224.9 2273.6 2233.8 2239.4 2242.0 2243.6 2244.2 2166.3 2262.8 2263.8 2264.5 2264.7 2196.3 2233.3 2235.3 2255.7 2262.4 2168.6 2169.0 2184.1 2193.0 2251.4 7889.4 7945.6 7950.0 7993.2 7998.4 4630.0 4715.8 4747.8 4751.0 4760.6 2895.9 3019.1 3030.4 3037.9 3045.6 947.2 950.5 967.4 993.1 1004.1 10695.9 10726.7 10728.8 10741.5 10800.6 3851.3 3925.8 3967.8 4043.9 4047.0 8916.7 9129.6 9155.0 9190.4 9203.0 4613.3 4630.6 4636.6 4663.9 4665.4 4207.0 4237.5 4238.6 4248.7 4249.5 3317.5 3360.7 3454.5 3598.4 3698.8 1102.9 1105.9 1106.9 1107.8 1109.0 1145.9 1299.5 1325.4 1355.5 1365.5 7470.1 7533.5 7631.4 7684.5 7692.1 1114.4 1136.0 1140.2 1142.3 1148.5 5648.8 5945.1 5949.0 5974.8 5983.3 9541.3 9565.1 9784.5 9790.0 9798.5 9642.0 9704.9 9716.6 9722.1 9729.7 6911.2 7168.3 7256.7 7260.3 7283.0 7274.5 7340.1 7348.9 7354.5 7365.1 8452.4 8535.2 8570.4 8595.6 8814.7 8662.3 8889.0 8964.8 9106.0 9114.2 6806.3 6816.3 6927.9 6930.3 6987.1 6725.4 6874.5 7287.7 7604.5 7616.7 6871.2 6920.0 6992.8 7017.8 7208.1 6697.3 6861.9 6900.5 6944.1 6997.3 7022.7 7067.0 7067.0 7090.5 7099.6 6216.3 6458.6 6495.3 6526.0 6541.5 6642.9 6671.2 6671.5 6713.8 6742.2 11:17:00 INFO - PROCESS | 3393 | 11:17:00 INFO - PROCESS | 3393 | [#4] prototype.html Cycles:180 Average:5104.26 Median:5842.80 stddev:1519.55 (26.0%) stddev-sans-first:1480.60 11:17:00 INFO - PROCESS | 3393 | Values: 310.5 318.9 330.4 330.6 333.7 5575.6 5750.3 5759.7 5761.5 5761.9 5562.2 5637.8 5641.1 5646.9 5673.6 4449.6 4454.0 4454.5 4455.0 4460.2 4251.1 4350.0 4366.7 4426.5 4431.8 4381.4 4384.8 4386.6 4389.2 4398.3 4381.7 4384.1 4385.3 4394.7 4401.0 3910.0 3913.8 3914.7 3919.7 3924.5 5322.4 5420.7 5432.6 5437.5 5453.8 5149.5 5152.7 5158.4 5163.8 5166.2 5973.6 6028.5 6030.5 6033.3 6033.7 4146.0 4201.5 4244.8 4291.4 4304.6 6193.0 6207.3 6208.1 6212.2 6215.6 4392.9 4411.8 4419.2 4420.0 4422.0 4279.1 4472.6 4475.9 4483.7 4485.6 4971.9 4985.0 4985.9 4989.1 4990.3 5966.8 5971.0 5975.4 5975.8 5979.9 1589.7 1610.4 1610.7 1611.3 1611.8 1069.8 1087.6 1096.1 1101.1 1103.2 5858.6 5861.1 5862.9 5867.1 5876.7 6170.5 6185.6 6195.6 6200.8 6228.8 5827.0 5876.1 5877.4 5884.2 5885.9 3281.5 3360.0 3370.3 3373.3 3379.5 6620.0 6625.2 6632.9 6635.0 6635.4 6414.4 6420.5 6421.8 6427.4 6434.6 6466.1 6597.2 6620.4 6622.9 6624.0 6142.1 6204.9 6214.7 6218.6 6222.7 5969.8 6107.8 6110.7 6149.7 6175.6 6512.3 6630.6 6637.4 6655.8 6666.0 4457.5 4464.0 4465.8 4467.1 4482.3 6142.5 6266.1 6281.0 6284.5 6285.4 6082.1 6133.7 6133.9 6143.0 6146.6 6137.2 6138.4 6140.4 6141.5 6142.5 5930.3 6011.1 6022.4 6032.9 6044.1 6106.1 6155.9 6157.4 6168.3 6170.7 5985.5 6023.8 6028.2 6030.2 6033.0 11:17:00 INFO - PROCESS | 3393 | 11:17:00 INFO - PROCESS | 3393 | [#5] yui.html Cycles:180 Average:12682.17 Median:43591.67 stddev:14077.97 (32.3%) stddev-sans-first:14089.23 11:17:00 INFO - PROCESS | 3393 | Values: 810.8 811.5 814.4 816.8 826.3 11819.5 12048.5 12129.4 12140.2 12144.5 11528.6 11545.9 11573.7 11582.9 11583.2 757.8 774.4 774.6 774.7 775.3 642.8 647.9 650.7 756.2 765.1 792.0 799.4 799.9 800.1 800.3 790.5 792.5 792.8 793.2 796.9 492.3 499.3 585.6 591.1 591.9 11279.4 11294.0 11296.0 11331.2 11331.3 12242.6 12648.4 12710.4 12861.9 12900.8 10490.2 10516.0 10557.3 10624.3 10737.0 3462.1 3532.8 3622.2 3622.3 3622.4 43158.0 43514.6 43907.0 44988.8 45189.8 9708.9 9858.2 9879.8 9974.4 10115.3 15588.2 15876.0 15921.4 15924.8 16230.4 7242.2 7363.7 7386.4 7526.5 7581.8 4227.7 4281.3 4344.1 4399.0 4450.2 2842.5 2870.7 2878.1 2879.4 2898.3 551.7 555.6 560.4 564.8 569.4 583.9 630.1 680.2 695.9 702.2 8471.7 8897.4 8935.0 9120.9 9483.7 573.6 614.0 666.2 682.4 704.9 3901.7 4077.6 4118.9 4127.8 4184.2 50940.7 51076.5 51303.5 51383.5 51386.2 25629.8 25846.4 25888.2 49214.8 49844.5 42555.6 43480.8 43668.8 43672.0 43782.8 8559.2 8763.0 8766.1 8851.4 8923.7 32675.2 32766.9 34089.7 34614.1 36287.8 41133.6 41350.2 41778.4 41820.8 41985.0 10326.4 10575.6 10701.4 10759.8 10950.3 12201.6 12370.4 12426.5 12753.4 12803.9 10863.4 11040.1 11155.4 11175.7 11532.7 11403.6 11726.5 11735.0 12141.4 12144.4 11310.8 11630.5 11723.8 11817.3 11943.4 8998.5 9624.3 9779.2 9969.9 9979.4 8328.9 8745.5 8781.7 9203.2 9570.8 11:17:00 INFO - PROCESS | 3393 | -------- Summary: end -------- 11:17:00 INFO - PROCESS | 3393 | 11:17:01 INFO - TEST-INFO | 3393: exit 0 11:17:01 INFO - TEST-OK | dromaeo_css | took 1116594ms 11:17:01 INFO - TEST-START | kraken 11:17:01 INFO - operating with platform_type : linux_ 11:17:01 INFO - Initialising browser for kraken test... 11:17:01 INFO - TEST-INFO | started process 3581 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7f81OC/profile http://localhost:42633/getInfo.html) 11:17:05 INFO - PROCESS | 3581 | __metrics Screen width/height:1600/1200 11:17:05 INFO - PROCESS | 3581 | colorDepth:24 11:17:05 INFO - PROCESS | 3581 | Browser inner width/height: 1024/697 11:17:05 INFO - PROCESS | 3581 | __metrics 11:17:05 INFO - PROCESS | 3581 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:17:05 INFO - PROCESS | 3581 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:17:06 INFO - TEST-INFO | 3581: exit 0 11:17:06 INFO - Browser initialized. 11:17:06 INFO - Running cycle 1/1 for kraken test... 11:17:06 INFO - TEST-INFO | started process 3671 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp7f81OC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:17:18 INFO - PROCESS | 3671 | RSS: Main: 149106688 11:17:18 INFO - PROCESS | 3671 | 11:17:20 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:42633/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42633/tests/kraken/driver.html?testName=audio-beat-detection) 11:17:21 INFO - PROCESS | 3671 | RSS: Main: 189173760 11:17:21 INFO - PROCESS | 3671 | 11:17:24 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:42633/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42633/tests/kraken/driver.html?testName=audio-dft) 11:17:24 INFO - PROCESS | 3671 | RSS: Main: 177090560 11:17:24 INFO - PROCESS | 3671 | 11:17:27 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:42633/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42633/tests/kraken/driver.html?testName=audio-fft) 11:17:28 INFO - PROCESS | 3671 | RSS: Main: 159588352 11:17:28 INFO - PROCESS | 3671 | 11:17:30 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:42633/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42633/tests/kraken/driver.html?testName=audio-oscillator) 11:17:30 INFO - PROCESS | 3671 | RSS: Main: 164323328 11:17:30 INFO - PROCESS | 3671 | 11:17:32 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:42633/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42633/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:17:33 INFO - PROCESS | 3671 | RSS: Main: 164261888 11:17:33 INFO - PROCESS | 3671 | 11:17:36 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:42633/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42633/tests/kraken/driver.html?testName=imaging-darkroom) 11:17:36 INFO - PROCESS | 3671 | RSS: Main: 164835328 11:17:36 INFO - PROCESS | 3671 | 11:17:40 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:42633/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42633/tests/kraken/driver.html?testName=imaging-desaturate) 11:17:40 INFO - PROCESS | 3671 | RSS: Main: 164560896 11:17:40 INFO - PROCESS | 3671 | 11:17:43 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:42633/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42633/tests/kraken/driver.html?testName=json-parse-financial) 11:17:44 INFO - PROCESS | 3671 | RSS: Main: 166658048 11:17:44 INFO - PROCESS | 3671 | 11:17:45 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:42633/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42633/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:17:46 INFO - PROCESS | 3671 | RSS: Main: 178249728 11:17:46 INFO - PROCESS | 3671 | 11:17:48 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:42633/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42633/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:17:48 INFO - PROCESS | 3671 | RSS: Main: 176668672 11:17:48 INFO - PROCESS | 3671 | 11:17:50 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:42633/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42633/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:17:51 INFO - PROCESS | 3671 | RSS: Main: 183042048 11:17:51 INFO - PROCESS | 3671 | 11:17:53 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:42633/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:17:54 INFO - PROCESS | 3671 | RSS: Main: 189911040 11:17:54 INFO - PROCESS | 3671 | 11:17:56 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:42633/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:17:57 INFO - PROCESS | 3671 | RSS: Main: 189128704 11:17:57 INFO - PROCESS | 3671 | 11:17:59 INFO - PROCESS | 3671 | Cycle 1(1): loaded http://localhost:42633/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42633/tests/kraken/driver.html?testName=ai-astar) 11:17:59 INFO - PROCESS | 3671 | RSS: Main: 247148544 11:17:59 INFO - PROCESS | 3671 | 11:17:59 INFO - PROCESS | 3671 | __start_tp_report 11:17:59 INFO - PROCESS | 3671 | _x_x_mozilla_page_load 11:17:59 INFO - PROCESS | 3671 | _x_x_mozilla_page_load_details 11:17:59 INFO - PROCESS | 3671 | |i|pagename|runs| 11:17:59 INFO - PROCESS | 3671 | |0;ai-astar;110;111;103;110;109;111;101;111;110;117 11:17:59 INFO - PROCESS | 3671 | |1;audio-beat-detection;158;127;149;169;129;154;155;134;179;128 11:17:59 INFO - PROCESS | 3671 | |2;audio-dft;162;162;164;161;162;162;160;164;164;165 11:17:59 INFO - PROCESS | 3671 | |3;audio-fft;72;71;84;93;72;71;72;107;92;73 11:17:59 INFO - PROCESS | 3671 | |4;audio-oscillator;97;96;141;95;96;95;141;97;96;146 11:17:59 INFO - PROCESS | 3671 | |5;imaging-gaussian-blur;109;109;109;110;109;109;109;109;109;108 11:17:59 INFO - PROCESS | 3671 | |6;imaging-darkroom;146;144;145;145;146;147;145;145;145;146 11:17:59 INFO - PROCESS | 3671 | |7;imaging-desaturate;104;97;95;96;96;95;96;96;95;95 11:17:59 INFO - PROCESS | 3671 | |8;json-parse-financial;56;57;59;55;57;56;57;65;55;57 11:17:59 INFO - PROCESS | 3671 | |9;json-stringify-tinderbox;67;67;67;68;74;68;69;68;67;68 11:17:59 INFO - PROCESS | 3671 | |10;stanford-crypto-aes;83;85;85;85;88;84;87;86;86;86 11:17:59 INFO - PROCESS | 3671 | |11;stanford-crypto-ccm;124;117;120;115;124;118;128;130;121;118 11:17:59 INFO - PROCESS | 3671 | |12;stanford-crypto-pbkdf2;144;141;149;154;142;143;147;153;149;138 11:17:59 INFO - PROCESS | 3671 | |13;stanford-crypto-sha256-iterative;68;68;68;68;70;66;67;67;68;67 11:17:59 INFO - PROCESS | 3671 | __end_tp_report 11:17:59 INFO - PROCESS | 3671 | __start_cc_report 11:17:59 INFO - PROCESS | 3671 | _x_x_mozilla_cycle_collect,922 11:17:59 INFO - PROCESS | 3671 | __end_cc_report 11:17:59 INFO - PROCESS | 3671 | __startTimestamp1452280679360__endTimestamp 11:17:59 INFO - PROCESS | 3671 | 11:17:59 INFO - PROCESS | 3671 | ------- Summary: start ------- 11:17:59 INFO - PROCESS | 3671 | Number of tests: 14 11:17:59 INFO - PROCESS | 3671 | 11:17:59 INFO - PROCESS | 3671 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.50 stddev:4.45 (4.0%) stddev-sans-first:4.71 11:17:59 INFO - PROCESS | 3671 | Values: 110.0 111.0 103.0 110.0 109.0 111.0 101.0 111.0 110.0 117.0 11:17:59 INFO - PROCESS | 3671 | 11:17:59 INFO - PROCESS | 3671 | [#1] audio-beat-detection Cycles:10 Average:148.20 Median:154.50 stddev:18.21 (11.8%) stddev-sans-first:18.97 11:17:59 INFO - PROCESS | 3671 | Values: 158.0 127.0 149.0 169.0 129.0 154.0 155.0 134.0 179.0 128.0 11:17:59 INFO - PROCESS | 3671 | 11:17:59 INFO - PROCESS | 3671 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.58 (1.0%) stddev-sans-first:1.66 11:17:59 INFO - PROCESS | 3671 | Values: 162.0 162.0 164.0 161.0 162.0 162.0 160.0 164.0 164.0 165.0 11:17:59 INFO - PROCESS | 3671 | 11:17:59 INFO - PROCESS | 3671 | [#3] audio-fft Cycles:10 Average:80.70 Median:72.50 stddev:12.72 (17.5%) stddev-sans-first:13.10 11:17:59 INFO - PROCESS | 3671 | Values: 72.0 71.0 84.0 93.0 72.0 71.0 72.0 107.0 92.0 73.0 11:17:59 INFO - PROCESS | 3671 | 11:17:59 INFO - PROCESS | 3671 | [#4] audio-oscillator Cycles:10 Average:110.00 Median:96.00 stddev:22.59 (23.5%) stddev-sans-first:23.47 11:17:59 INFO - PROCESS | 3671 | Values: 97.0 96.0 141.0 95.0 96.0 95.0 141.0 97.0 96.0 146.0 11:17:59 INFO - PROCESS | 3671 | 11:17:59 INFO - PROCESS | 3671 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 11:17:59 INFO - PROCESS | 3671 | Values: 109.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 109.0 108.0 11:17:59 INFO - PROCESS | 3671 | 11:17:59 INFO - PROCESS | 3671 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 11:17:59 INFO - PROCESS | 3671 | Values: 146.0 144.0 145.0 145.0 146.0 147.0 145.0 145.0 145.0 146.0 11:17:59 INFO - PROCESS | 3671 | 11:17:59 INFO - PROCESS | 3671 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:2.72 (2.8%) stddev-sans-first:0.71 11:17:59 INFO - PROCESS | 3671 | Values: 104.0 97.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 11:17:59 INFO - PROCESS | 3671 | 11:17:59 INFO - PROCESS | 3671 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:57.00 stddev:2.91 (5.1%) stddev-sans-first:3.05 11:17:59 INFO - PROCESS | 3671 | Values: 56.0 57.0 59.0 55.0 57.0 56.0 57.0 65.0 55.0 57.0 11:17:59 INFO - PROCESS | 3671 | 11:17:59 INFO - PROCESS | 3671 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:2.11 (3.1%) stddev-sans-first:2.19 11:17:59 INFO - PROCESS | 3671 | Values: 67.0 67.0 67.0 68.0 74.0 68.0 69.0 68.0 67.0 68.0 11:17:59 INFO - PROCESS | 3671 | 11:17:59 INFO - PROCESS | 3671 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:86.00 stddev:1.43 (1.7%) stddev-sans-first:1.20 11:17:59 INFO - PROCESS | 3671 | Values: 83.0 85.0 85.0 85.0 88.0 84.0 87.0 86.0 86.0 86.0 11:17:59 INFO - PROCESS | 3671 | 11:17:59 INFO - PROCESS | 3671 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:122.50 stddev:4.90 (4.0%) stddev-sans-first:5.12 11:17:59 INFO - PROCESS | 3671 | Values: 124.0 117.0 120.0 115.0 124.0 118.0 128.0 130.0 121.0 118.0 11:17:59 INFO - PROCESS | 3671 | 11:17:59 INFO - PROCESS | 3671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.00 Median:148.00 stddev:5.27 (3.6%) stddev-sans-first:5.54 11:17:59 INFO - PROCESS | 3671 | Values: 144.0 141.0 149.0 154.0 142.0 143.0 147.0 153.0 149.0 138.0 11:17:59 INFO - PROCESS | 3671 | 11:17:59 INFO - PROCESS | 3671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 11:17:59 INFO - PROCESS | 3671 | Values: 68.0 68.0 68.0 68.0 70.0 66.0 67.0 67.0 68.0 67.0 11:17:59 INFO - PROCESS | 3671 | -------- Summary: end -------- 11:17:59 INFO - PROCESS | 3671 | 11:18:00 INFO - TEST-INFO | 3671: exit 0 11:18:00 INFO - TEST-OK | kraken | took 58998ms 11:18:00 INFO - TEST-START | v8_7 11:18:00 INFO - operating with platform_type : linux_ 11:18:00 INFO - Initialising browser for v8_7 test... 11:18:00 INFO - TEST-INFO | started process 3922 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4SQIvp/profile http://localhost:42633/getInfo.html) 11:18:04 INFO - PROCESS | 3922 | __metrics Screen width/height:1600/1200 11:18:04 INFO - PROCESS | 3922 | colorDepth:24 11:18:04 INFO - PROCESS | 3922 | Browser inner width/height: 1024/697 11:18:04 INFO - PROCESS | 3922 | __metrics 11:18:04 INFO - PROCESS | 3922 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:18:04 INFO - PROCESS | 3922 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:18:05 INFO - TEST-INFO | 3922: exit 0 11:18:05 INFO - Browser initialized. 11:18:05 INFO - Running cycle 1/1 for v8_7 test... 11:18:05 INFO - TEST-INFO | started process 4005 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4SQIvp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:18:17 INFO - PROCESS | 4005 | RSS: Main: 148611072 11:18:17 INFO - PROCESS | 4005 | 11:18:39 INFO - PROCESS | 4005 | Cycle 1(1): loaded http://localhost:42633/tests/v8_7/run.html (next: http://localhost:42633/tests/v8_7/run.html) 11:18:40 INFO - PROCESS | 4005 | RSS: Main: 540626944 11:18:40 INFO - PROCESS | 4005 | 11:18:40 INFO - PROCESS | 4005 | __start_tp_report 11:18:40 INFO - PROCESS | 4005 | _x_x_mozilla_page_load 11:18:40 INFO - PROCESS | 4005 | _x_x_mozilla_page_load_details 11:18:40 INFO - PROCESS | 4005 | |i|pagename|runs| 11:18:40 INFO - PROCESS | 4005 | |0;Richards;168.03898504453034 11:18:40 INFO - PROCESS | 4005 | |1;DeltaBlue;190.04180919802357 11:18:40 INFO - PROCESS | 4005 | |2;Encrypt;280.8988764044944 11:18:40 INFO - PROCESS | 4005 | |3;Decrypt;5181.347150259067 11:18:40 INFO - PROCESS | 4005 | |4;RayTrace;1960.7843137254902 11:18:40 INFO - PROCESS | 4005 | |5;Earley;806.4516129032259 11:18:40 INFO - PROCESS | 4005 | |6;Boyer;11940.47619047619 11:18:40 INFO - PROCESS | 4005 | |7;RegExp;42408.163265306124 11:18:40 INFO - PROCESS | 4005 | |8;Splay;581.0575246949448 11:18:40 INFO - PROCESS | 4005 | |9;NavierStokes;4826.923076923077 11:18:40 INFO - PROCESS | 4005 | __end_tp_report 11:18:40 INFO - PROCESS | 4005 | __startTimestamp1452280720104__endTimestamp 11:18:40 INFO - PROCESS | 4005 | 11:18:40 INFO - PROCESS | 4005 | ------- Summary: start ------- 11:18:40 INFO - PROCESS | 4005 | Number of tests: 10 11:18:40 INFO - PROCESS | 4005 | 11:18:40 INFO - PROCESS | 4005 | [#0] Richards Cycles:1 Average:168.04 Median:168.04 stddev:0.00 (0.0%) 11:18:40 INFO - PROCESS | 4005 | Values: 168.0 11:18:40 INFO - PROCESS | 4005 | 11:18:40 INFO - PROCESS | 4005 | [#1] DeltaBlue Cycles:1 Average:190.04 Median:190.04 stddev:0.00 (0.0%) 11:18:40 INFO - PROCESS | 4005 | Values: 190.0 11:18:40 INFO - PROCESS | 4005 | 11:18:40 INFO - PROCESS | 4005 | [#2] Encrypt Cycles:1 Average:280.90 Median:280.90 stddev:0.00 (0.0%) 11:18:40 INFO - PROCESS | 4005 | Values: 280.9 11:18:40 INFO - PROCESS | 4005 | 11:18:40 INFO - PROCESS | 4005 | [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 11:18:40 INFO - PROCESS | 4005 | Values: 5181.3 11:18:40 INFO - PROCESS | 4005 | 11:18:40 INFO - PROCESS | 4005 | [#4] RayTrace Cycles:1 Average:1960.78 Median:1960.78 stddev:0.00 (0.0%) 11:18:40 INFO - PROCESS | 4005 | Values: 1960.8 11:18:40 INFO - PROCESS | 4005 | 11:18:40 INFO - PROCESS | 4005 | [#5] Earley Cycles:1 Average:806.45 Median:806.45 stddev:0.00 (0.0%) 11:18:40 INFO - PROCESS | 4005 | Values: 806.5 11:18:40 INFO - PROCESS | 4005 | 11:18:40 INFO - PROCESS | 4005 | [#6] Boyer Cycles:1 Average:11940.48 Median:11940.48 stddev:0.00 (0.0%) 11:18:40 INFO - PROCESS | 4005 | Values: 11940.5 11:18:40 INFO - PROCESS | 4005 | 11:18:40 INFO - PROCESS | 4005 | [#7] RegExp Cycles:1 Average:42408.16 Median:42408.16 stddev:0.00 (0.0%) 11:18:40 INFO - PROCESS | 4005 | Values: 42408.2 11:18:40 INFO - PROCESS | 4005 | 11:18:40 INFO - PROCESS | 4005 | [#8] Splay Cycles:1 Average:581.06 Median:581.06 stddev:0.00 (0.0%) 11:18:40 INFO - PROCESS | 4005 | Values: 581.1 11:18:40 INFO - PROCESS | 4005 | 11:18:40 INFO - PROCESS | 4005 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 11:18:40 INFO - PROCESS | 4005 | Values: 4826.9 11:18:40 INFO - PROCESS | 4005 | -------- Summary: end -------- 11:18:40 INFO - PROCESS | 4005 | 11:18:40 INFO - TEST-INFO | 4005: exit 0 11:18:40 INFO - TEST-OK | v8_7 | took 40718ms 11:18:40 INFO - SUITE-END | took 1216s 11:18:41 INFO - Completed test suite (00:20:16) 11:18:41 INFO - Working with test: dromaeo_css 11:18:41 INFO - Generating results file: dromaeo_css 11:18:41 INFO - Working with test: kraken 11:18:41 INFO - Generating results file: kraken 11:18:41 INFO - javascript benchmark 11:18:41 INFO - Working with test: v8_7 11:18:41 INFO - Generating results file: v8_7 11:18:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:18:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 11:18:41 INFO - process_Request line: dromaeo_css 6591.64 graph.html#tests=[[72,201,35]] 11:18:41 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:18:41 INFO - process_Request line: kraken 1508.10 graph.html#tests=[[232,201,35]] 11:18:41 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:18:41 INFO - process_Request line: v8_7 18974.22 graph.html#tests=[[230,201,35]] 11:18:41 INFO - RETURN: dromaeo_css: 6591.64 11:18:41 INFO - RETURN: kraken: 1508.10 11:18:41 INFO - RETURN: v8_7: 18974.22 11:18:41 INFO - javascript benchmark 11:18:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3030.2272920405294, 3066.5246886732566, 3105.6739042400545, 3111.626604807422, 3121.5629811826343, 4882.218844984804, 4980.178270585349, 5043.697378157313, 5066.265391518227, 5076.010178015288, 4925.458199598051, 4985.750712464372, 5003.774830132644, 5012.423571289303, 5021.422536408314, 4360.062586543892, 4537.523560026199, 4580.410045367771, 4667.043256132485, 4672.64955128365, 4528.298113792367, 4583.495815460296, 4628.30575413689, 4634.930476042862, 4703.5061318561575, 4487.282034874404, 4598.402207713009, 4602.792874320664, 4622.375979242793, 4657.11514812188, 4582.427196600425, 4593.678442509025, 4593.701409408378, 4600.102979918917, 4620.953790462119, 4483.327500874862, 4544.386507821435, 4554.339620755005, 4569.565891240327, 4606.792694328729, 4864.391951006124, 4868.829590964335, 4970.676906001098, 4977.90044199114, 5007.048660754445, 5405.891882162335, 5417.729113544347, 5422.0511410503395, 5424.349078110613, 5476.945230547723, 5287.709175995319, 5398.6220964532495, 5438.129899216146, 5439.347278326587, 5443.0, 4998.90002199954, 5050.292958985745, 5067.189249720027, 5071.188609822448, 5113.2330150477355, 5536.695481748542, 5544.417836127229, 5551.8889622208135, 5597.216389705444, 5605.383407825136, 5161.74191290434, 5237.6333656643665, 5266.578673706171, 5288.735563221823, 5312.362516498045, 5367.275417818622, 5418.512333889968, 5420.945790542123, 5421.295231619864, 5467.043267428264, 5315.468453154654, 5366.221897824794, 5370.4629537045985, 5378.300820893259, 5407.810726624628, 5268.710220937885, 5310.973445132827, 5355.866103347447, 5372.140457526777, 5383.16560933056, 4252.659787217015, 4271.209826182167, 4275.615194632498, 4296.419983302277, 4313.288307429302, 3787.223619158066, 3823.9617603824163, 3831.2146010068427, 3853.3641949078087, 3865.3042452358845, 5031.874203144877, 5142.1772516397195, 5143.974280128576, 5188.247704082887, 5205.791768329224, 5377.623566350396, 5443.074677304868, 5443.836684899459, 5470.152126420411, 5509.779608815603, 5174.534291913746, 5194.0910340690225, 5196.376434827845, 5200.2199670049795, 5251.868703282448, 4583.060472603109, 4679.719216847, 4682.555157260055, 4708.458527269339, 4709.576138147583, 5686.118651609007, 5770.682612456355, 5775.220345253421, 5775.451332123525, 5821.0, 5349.491798279158, 5357.410684824744, 5368.597355198453, 5368.812091576776, 5385.973070134624, 5559.33288005442, 5591.944080559142, 5647.6893770843, 5654.7455364509515, 5668.404817494104, 5266.605004624746, 5314.335708036496, 5361.731913404392, 5366.892662146814, 5371.543418809445, 5370.248165256789, 5378.569714422915, 5408.75660595282, 5415.891682166256, 5418.997485465202, 5127.41034781005, 5265.447128051499, 5284.418713941386, 5286.36563612369, 5332.840014799563, 5107.489251074863, 5225.3990791057995, 5242.030224408497, 5243.344581927259, 5289.2330612061805, 5137.537621614073, 5151.150060240018, 5154.098032844312, 5154.639175257696, 5203.16749320107, 5154.819581314636, 5240.4759524047295, 5245.0821106307, 5250.448702886295, 5267.341582302212, 5036.395632524121, 5101.872453188552, 5133.820316289061, 5183.041137389595, 5190.97404512975], "unit": "score", "name": "dojo.html", "value": 4992.5385602482975}, {"lowerIsBetter": false, "replicates": [535.7241020874251, 551.5504863536217, 561.8341940473517, 572.0332637842049, 586.2876604925016, 28115.15654530365, 28832.279193020186, 28834.134975950703, 28867.13398598043, 35724.82137589309, 38577.61422385775, 39042.21915561687, 39049.609503904954, 39098.8045059775, 39147.99999999993, 8352.791180220498, 8559.0, 8562.315014798802, 8617.439866408695, 8628.65485380584, 7472.4395670324675, 7668.07983042033, 8282.668693252263, 8405.873911891327, 9879.555420006118, 10025.34835235711, 10027.298089133763, 10110.0, 10122.595096196143, 10132.645357412492, 9887.604495820158, 9990.150837178848, 9995.250831104564, 9999.450030248334, 9999.700008999742, 7464.141623713288, 7648.694052237904, 9985.20118390527, 10321.43232122233, 10321.43232122233, 35703.821480892686, 36354.45468317977, 36378.63621363779, 36387.0, 36391.81804090989, 3105.099521138867, 3128.702773236539, 3149.6377916539664, 3170.4927211646254, 3266.2324353776844, 25651.658473916366, 25793.74206257932, 26186.214413567624, 26318.73681263182, 26353.0, 3473.166440054394, 3499.61504234534, 3539.29214157167, 3594.2991116732246, 3654.086478380405, 272587.0, 272713.0, 272783.0, 272807.0, 274811.0, 52274.738626307386, 53207.46792532103, 53809.1928621071, 53870.730646346514, 53937.46062539403, 64603.67698161479, 65159.0, 65458.0, 65503.67248163729, 65660.0, 14183.503577374742, 14190.361433735507, 14196.858031419553, 14326.355314010894, 14341.713165736626, 9665.178459830853, 9895.901040989642, 11947.880521194676, 12163.452644630835, 12424.56514022005, 19444.416667499714, 19519.219231230876, 19659.60680786376, 19695.60608787816, 20330.59338813245, 7390.22402647725, 7643.235676432423, 7646.235376462309, 7755.0224692703, 7773.950516680289, 869.3262721390972, 906.2659246010752, 954.0793134624981, 1044.4151275285865, 1046.2571574182416, 28219.57670634942, 28500.572491412644, 28728.425431491254, 28946.27634309117, 29039.56440653392, 1033.705393962717, 1067.9412632305143, 1097.5774326884048, 1106.5186643809968, 1134.852469179018, 14886.851131488764, 15365.0, 15381.307841147176, 15411.61470963235, 15642.530724078295, 323731.0, 326895.0, 327072.0, 327867.0, 328483.0, 45230.547694523295, 52696.73651631794, 52947.47052529425, 52952.70472952751, 52965.7351713239, 1333.4266265505926, 1346.2461021827612, 1356.6404902700792, 1358.952436664712, 1359.5037811199038, 25945.22164335073, 25982.480350393264, 27822.721772782013, 28453.43093138167, 28553.571696424155, 39776.80111599423, 40597.594024059385, 43316.0, 44428.55571444244, 48256.10463372209, 237486.0, 239477.0, 239796.0, 241122.0, 241602.0, 32301.192470188435, 32625.836870815496, 32683.346333072728, 32698.83650581732, 32750.50874236936, 42235.0, 42744.572554275306, 43286.56713432951, 43597.47408840675, 44449.55550444584, 35304.64695353116, 36096.4585531212, 36480.270394591425, 36552.45171322486, 37191.44212836864, 32950.50574241436, 33322.333553329285, 33723.66276337205, 33899.66100338965, 34247.143821404665, 34777.13057173591, 35462.46806297959, 35471.0, 35548.28903421865, 35737.64262357447, 30531.389372212874, 31501.36997259996, 32001.839990799897, 32024.67975320217, 32056.198595034377, 24576.262712118663, 24777.504449911263, 24815.379615509755, 25019.74980250174, 25149.497010060062], "unit": "score", "name": "ext.html", "value": 17986.415307119812}, {"lowerIsBetter": false, "replicates": [354.9378858699727, 356.532867251261, 357.53877498027543, 357.5494876455665, 357.662009401116, 12954.35228238589, 13363.0, 15643.687126257468, 15832.287547060381, 16318.673626527463, 14506.637334066654, 14679.486217982372, 16182.919085404557, 16372.83627163728, 16391.18044097796, 5101.974490127563, 5276.630635855492, 5378.46215378461, 5385.380681221671, 5390.460953904598, 3923.9215215695667, 4019.477467929165, 5265.262863199156, 5596.104623260258, 5822.621529600562, 5668.186180422266, 5713.257276554063, 5730.742116604742, 5777.45114214149, 5780.739866706008, 5764.481196692297, 5805.622634528742, 5820.3597604263705, 5821.3596504384695, 5823.097419899922, 5055.140626093573, 5124.205748109049, 5217.113090774577, 5222.92165617516, 5225.425203227642, 19223.807761922482, 19259.0, 19523.707144392847, 19548.12033458498, 19585.412437626896, 1970.6649869522073, 2068.2225498811063, 2115.101082040142, 2238.787315205053, 2325.03511042917, 10621.787564248749, 12333.197741906677, 12356.0, 12448.439820208112, 12941.417636206299, 1766.0904634113442, 1777.3423833181675, 1797.6854050541233, 1818.6817306971227, 1819.9090045497671, 53090.46909530894, 53939.46060539383, 54321.456785432034, 54908.0, 55231.72384138094, 9384.718458446258, 9419.858702119336, 9432.717018489457, 9476.478793666414, 9505.0, 12076.637700868989, 12088.758224835454, 12144.939275303566, 12169.452374643162, 12196.512139514498, 6669.532702805375, 6807.081044059088, 6830.975353696886, 7010.894836577456, 7072.328128827753, 6735.393814556714, 6798.932010679929, 6804.795856124324, 6828.658567071627, 6856.554323969026, 3593.802340871277, 4064.9796751016056, 4097.8975525612095, 4101.507819061731, 4139.751614903115, 1575.2045217165257, 1590.745480723102, 1676.555712736126, 1677.6057626458016, 1685.3231035119888, 404.7348986413904, 894.8031433084711, 940.4639355567398, 941.9576119074658, 970.3062310447923, 9106.31702622306, 9402.529873506297, 9948.751281218027, 10448.164146868232, 10957.56169753201, 426.2327809942092, 429.3623968406913, 438.3687490014369, 445.0, 448.95959363657425, 4883.658143929962, 5790.536757059509, 5902.3507414184405, 5914.349421563625, 5947.5539334550085, 512242.0, 525661.0, 534406.0, 534696.0, 535319.0, 70015.0, 71362.0, 71743.77153028126, 72800.63599681968, 73512.0, 472.8983268597268, 480.9278608208797, 482.55845901000896, 483.6227742360964, 485.5144855144855, 9813.411195328303, 9891.554880030271, 10043.799124017625, 10100.797984040424, 10244.385336879812, 29372.11883643494, 31951.680483194872, 33169.83415082909, 33625.15937101592, 33959.0, 35740.82129589439, 35801.46297805483, 36000.27999440049, 37298.0, 38141.427878581286, 6868.244493105654, 7225.747098851515, 7270.890936635848, 7299.379552738077, 7329.6701648427015, 9691.903080969381, 10519.105876000625, 10755.946220268848, 11169.72075698114, 11448.713782155513, 9585.856212156683, 9624.951875240578, 9818.312718109664, 9926.759155105612, 10324.793504130026, 7459.552426854406, 9441.0, 9844.704658860246, 9861.211103111591, 10066.597336106473, 9314.48770317639, 9554.522273886418, 9753.804923901624, 9939.801203975736, 9951.651692190739, 7258.854822903407, 7260.16508101554, 7286.526375785557, 7296.7081316746735, 7323.523970941872, 9369.484678342484, 9865.112139907444, 9905.801883962424, 9967.40195588267, 10032.799344013225], "unit": "score", "name": "jquery.html", "value": 7336.412303092555}, {"lowerIsBetter": false, "replicates": [1328.9136206146593, 1466.2668665667165, 1482.1996122094074, 1638.524827799938, 1790.579213884736, 7054.929450705491, 7697.961510192448, 7810.687572497093, 7814.960925195373, 7891.4081443891655, 7651.426143039281, 7797.0, 7797.791342341932, 7844.882326765103, 7856.8035799105055, 1907.551725344543, 1956.0513151121695, 2202.405350555357, 2224.855384400013, 2273.624851899435, 2233.8436309458343, 2239.3729755668437, 2242.0471299697565, 2243.618584840581, 2244.16965722682, 2166.2526428382184, 2262.8076613487874, 2263.818894488445, 2264.535770167112, 2264.682944387787, 2196.3081629286726, 2233.274185889576, 2235.3182279404773, 2255.6842042114035, 2262.4457008032973, 2168.6313326734494, 2169.034779523113, 2184.14818220894, 2192.967105493419, 2251.4371407148215, 7889.408294377888, 7945.64244608994, 7949.96025019877, 7993.160718124572, 7998.4001199910235, 4630.0, 4715.811367545329, 4747.810087596492, 4751.0, 4760.571548560646, 2895.8552072396506, 3019.139545229599, 3030.4090702313056, 3037.893673721409, 3045.6040714706946, 947.161761840769, 950.5199874063622, 967.3663750243531, 993.1062044160313, 1004.0912973758687, 10695.893041069645, 10726.678199654023, 10728.785424291471, 10741.462926853626, 10800.5679772809, 3851.287511810324, 3925.823337949799, 3967.7619342838943, 4043.8786836394956, 4047.0489434982755, 8916.73249802494, 9129.589168487433, 9154.954225228832, 9190.448573085636, 9203.0, 4613.30800379939, 4630.560096790799, 4636.629069674418, 4663.860084197479, 4665.393498845128, 4206.978965105155, 4237.491501019897, 4238.618524332825, 4248.681348898845, 4249.532551419341, 3317.5023746437746, 3360.7479439042168, 3454.4818277258614, 3598.3522965866396, 3698.7595806272507, 1102.9117670586495, 1105.8894110589038, 1106.9280496767685, 1107.789519991199, 1108.9944550277196, 1145.9025982791388, 1299.5191779041816, 1325.4168166006925, 1355.5120156743565, 1365.49476693624, 7470.140933792683, 7533.54798712079, 7631.3513351364645, 7684.538927664358, 7692.076950765944, 1114.4260705736551, 1135.982960255597, 1140.1790710688292, 1142.348861149137, 1148.5463242019355, 5648.790432858408, 5945.0785128304315, 5948.970255148696, 5974.761009559656, 5983.311919129356, 9541.284403669753, 9565.091316325077, 9784.510774461249, 9790.0, 9798.510074496247, 9641.951790241144, 9704.854427183598, 9716.61133554664, 9722.125008749246, 9729.70810875675, 6911.17065952089, 7168.2831716827895, 7256.7097316106765, 7260.346568808727, 7282.96358518204, 7274.454415918722, 7340.1191856975365, 7348.889766653398, 7354.485186036926, 7365.116186057493, 8452.366072544706, 8535.189157030072, 8570.4000719949, 8595.570221489026, 8814.735557933273, 8662.263707584925, 8888.955555222183, 8964.820703586021, 9106.0, 9114.225290850352, 6806.285340039224, 6816.284290149463, 6927.930720692729, 6930.306969303029, 6987.1266091738535, 6725.39471447572, 6874.450043996569, 7287.672054757442, 7604.5437273763755, 7616.7334143304715, 6871.244163141951, 6920.0, 6992.79021629352, 7017.754378596725, 7208.06295181644, 6697.2633010367845, 6861.897071544031, 6900.516963812485, 6944.062551555678, 6997.335253150943, 7022.719091236498, 7066.964665176642, 7067.045948797052, 7090.539114957512, 7099.609521476368, 6216.285127210248, 6458.580192287486, 6495.285518593046, 6526.0, 6541.542092053701, 6642.867142657024, 6671.199456065109, 6671.46628269747, 6713.798586042427, 6742.157230346207], "unit": "score", "name": "mootools.html", "value": 4483.076617436632}, {"lowerIsBetter": false, "replicates": [310.4954449020342, 318.9314297426053, 330.3821853134639, 330.63464871317194, 333.7346809286616, 5575.609707320479, 5750.338711048231, 5759.74081166348, 5761.539076873851, 5761.913571296429, 5562.249096371988, 5637.774489020434, 5641.12562552804, 5646.915296270549, 5673.574481913863, 4449.5995360417555, 4454.0, 4454.53227411122, 4454.97772511137, 4460.1525710114975, 4251.149770045988, 4350.0, 4366.67249956253, 4426.468823741156, 4431.778411079449, 4381.38660587518, 4384.780760961955, 4386.583274588925, 4389.231884420214, 4398.252297109483, 4381.715188512769, 4384.12317536494, 4385.298352263622, 4394.7143435676735, 4400.977995110036, 3910.0, 3913.8238779255003, 3914.6868250539887, 3919.686425086015, 3924.548676902136, 5322.414534401213, 5420.728963551846, 5432.619716619838, 5437.456254374571, 5453.83638490842, 5149.48505149482, 5152.690838549662, 5158.432572417031, 5163.7676304566385, 5166.225066240057, 5973.581849270553, 6028.457438830526, 6030.517558595302, 6033.306169790487, 6033.668148251844, 4145.958540414587, 4201.516825565038, 4244.808983595714, 4291.399204111427, 4304.5910638489295, 6193.009118541012, 6207.31719510858, 6208.1308616793685, 6212.192414986068, 6215.627062376272, 4392.934105988413, 4411.779411029435, 4419.226635338867, 4419.9779001105435, 4421.955780442218, 4279.144171165779, 4472.619827314649, 4475.910481790346, 4483.708558943658, 4485.618722408566, 4971.900561988812, 4984.975075124601, 4985.900281994413, 4989.101961646938, 4990.326305948651, 5966.761329546856, 5970.9701451492465, 5975.372585878507, 5975.760969561169, 5979.910301345483, 1589.6741168060519, 1610.3961014619517, 1610.7261765499893, 1611.3151910438016, 1611.7582362645696, 1069.775347177086, 1087.5595383869545, 1096.1395304685784, 1101.1411099342527, 1103.2056919018294, 5858.648481091148, 5861.062230043172, 5862.8534286642325, 5867.14926335679, 5876.706164691748, 6170.5372097092895, 6185.567010309325, 6195.597286176384, 6200.751969921243, 6228.813135605939, 5826.951148793258, 5876.118582212703, 5877.441643043904, 5884.205632239593, 5885.852853678607, 3281.5241789940324, 3359.9664003360144, 3370.2753907909428, 3373.2578832656777, 3379.4761811919193, 6619.966900165468, 6625.204975402886, 6632.90050649231, 6634.966825165843, 6635.435987940982, 6414.422701956846, 6420.5184611154355, 6421.839454013593, 6427.421532062043, 6434.646094464756, 6466.094746735461, 6597.175353080865, 6620.404163625297, 6622.86754264912, 6623.999999999904, 6142.078688196806, 6204.906926396198, 6214.658193799384, 6218.5647004709235, 6222.719977600928, 5969.791057312973, 6107.755689772537, 6110.7250173741395, 6149.692515374124, 6175.5677102602385, 6512.34876512345, 6630.635315057718, 6637.402633762985, 6655.833604159935, 6666.0, 4457.465104187519, 4463.977680111579, 4465.821367145278, 4467.061916997467, 4482.305242687388, 6142.491459078335, 6266.122742815918, 6281.0, 6284.528660350584, 6285.402886725754, 6082.148499210026, 6133.662648554194, 6133.938660613337, 6142.9864072427545, 6146.6004709693725, 6137.202163718866, 6138.416850399205, 6140.4473597376455, 6141.508679305734, 6142.508599311955, 5930.28836539618, 6011.128386383863, 6022.36765139654, 6032.8793424132145, 6044.123602077586, 6106.1451396803595, 6155.938440615716, 6157.353477884758, 6168.25980882297, 6170.6914654268, 5985.521158307412, 6023.849403764941, 6028.15605815195, 6030.185924900258, 6033.0], "unit": "score", "name": "prototype.html", "value": 4615.9031109993675}, {"lowerIsBetter": false, "replicates": [810.7689308547064, 811.5130921447129, 814.385139219889, 816.779469543223, 826.256369267659, 11819.468123934423, 12048.518059277618, 12129.393530323492, 12140.210886292385, 12144.453499592517, 11528.596499122532, 11545.942270288637, 11573.710657233574, 11582.942085289562, 11583.247088939233, 757.7878194105659, 774.3959711425098, 774.6126936531734, 774.6591499740124, 775.2983549887333, 642.7846671365074, 647.8833809914214, 650.72344253692, 756.1757684124303, 765.1353970013877, 791.9722809701661, 799.4284086877881, 799.9280064794167, 800.1198681450417, 800.3317230112863, 790.4861839804116, 792.4611264340247, 792.7661339904741, 793.1830214878655, 796.9362451003934, 492.2591499792789, 499.3059647090547, 585.5637550025258, 591.1015256809668, 591.8875413671389, 11279.43602819864, 11294.0, 11296.0, 11331.206815522917, 11331.32012079278, 12242.632721018384, 12648.430820613003, 12710.428030738547, 12861.87138128616, 12900.79252829922, 10490.160787137087, 10516.0, 10557.313774604703, 10624.309419887682, 10737.0, 3462.0998540379433, 3532.8056956867363, 3622.2031153146268, 3622.2574372253625, 3622.3660859349507, 43158.0, 43514.56485435137, 43907.0, 44988.77505612451, 45189.77405112986, 9708.90291097094, 9858.162056225301, 9879.776217116912, 9974.351667141613, 10115.291929564859, 15588.220588970506, 15876.0, 15921.363145474283, 15924.76112858308, 16230.350785968665, 7242.203357630657, 7363.705451781869, 7386.409087273005, 7526.548407095483, 7581.848363032708, 4227.704060715781, 4281.293586558183, 4344.066025804467, 4399.0, 4450.198964186413, 2842.474142283643, 2870.7129287071125, 2878.0502434196665, 2879.4385094906293, 2898.2899189698237, 551.7075949746641, 555.5916401444935, 560.4115678537601, 564.7599770097692, 569.4191924237255, 583.8744669895992, 630.1052505442283, 680.2347359220877, 695.8990946312756, 702.1574111066741, 8471.745847624581, 8897.421667591716, 8935.0, 9120.908790912139, 9483.715488535356, 573.5698226330252, 613.9631622102688, 666.2271764752863, 682.3654001778294, 704.9330313620197, 3901.668358189586, 4077.571854955187, 4118.897027574275, 4127.834886604563, 4184.225918205142, 50940.74529627402, 51076.48923510792, 51303.486965130614, 51383.486165138616, 51386.22920656193, 25629.796275465567, 25846.353841153745, 25888.223353299432, 49214.753926230136, 49844.50155498471, 42555.57444425516, 43480.782596086814, 43668.781656091516, 43672.0, 43782.781086095005, 8559.186877246651, 8762.956185219033, 8766.123387661182, 8851.380403371702, 8923.73228803137, 32675.18312042123, 32766.853160139282, 34089.659103408645, 34614.13464663403, 36287.81856090703, 41133.58866411417, 41350.1729965405, 41778.37332439955, 41820.79089604533, 41985.0, 10326.407145014307, 10575.576976920836, 10701.411422371844, 10759.838602421127, 10950.342979420942, 12201.572944946884, 12370.44333005035, 12426.502939882303, 12753.362331883554, 12803.935980320039, 10863.402512861869, 11040.116790656888, 11155.386453745123, 11175.72060698489, 11532.675246782457, 11403.600873969372, 11726.472308746297, 11735.0, 12141.39293035327, 12144.392780361124, 11310.830337545109, 11630.534778609099, 11723.765524689288, 11817.290962542274, 11943.402829858298, 8998.460092394478, 9624.326297159132, 9779.168770654574, 9969.850452243078, 9979.401235925867, 8328.875066873881, 8745.518996455256, 8781.692640757543, 9203.217726493323, 9570.760730981781], "unit": "score", "name": "yui.html", "value": 6016.466961794136}], "name": "dromaeo_css", "value": 6591.643608757939}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 103.0, 110.0, 109.0, 111.0, 101.0, 111.0, 110.0, 117.0], "unit": "score", "name": "ai-astar", "value": 109.3}, {"lowerIsBetter": true, "replicates": [158.0, 127.0, 149.0, 169.0, 129.0, 154.0, 155.0, 134.0, 179.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 164.0, 161.0, 162.0, 162.0, 160.0, 164.0, 164.0, 165.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 84.0, 93.0, 72.0, 71.0, 72.0, 107.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 141.0, 95.0, 96.0, 95.0, 141.0, 97.0, 96.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 110.0}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 108.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 144.0, 145.0, 145.0, 146.0, 147.0, 145.0, 145.0, 145.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [104.0, 97.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 59.0, 55.0, 57.0, 56.0, 57.0, 65.0, 55.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 57.4}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 68.0, 74.0, 68.0, 69.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 85.0, 85.0, 88.0, 84.0, 87.0, 86.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [124.0, 117.0, 120.0, 115.0, 124.0, 118.0, 128.0, 130.0, 121.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [144.0, 141.0, 149.0, 154.0, 142.0, 143.0, 147.0, 153.0, 149.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 70.0, 66.0, 67.0, 67.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.7}], "name": "kraken", "value": 1508.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.03898504453034], "unit": "score", "name": "Richards", "value": 210.08220199999997}, {"lowerIsBetter": false, "replicates": [190.04180919802357], "unit": "score", "name": "DeltaBlue", "value": 347.91291599999994}, {"lowerIsBetter": false, "replicates": [280.8988764044944], "unit": "score", "name": "Encrypt", "value": 947.6043599999998}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1960.7843137254902], "unit": "score", "name": "RayTrace", "value": 377.39439}, {"lowerIsBetter": false, "replicates": [806.4516129032259], "unit": "score", "name": "Earley", "value": 826.4141199999997}, {"lowerIsBetter": false, "replicates": [11940.47619047619], "unit": "score", "name": "Boyer", "value": 55.815445663010976}, {"lowerIsBetter": false, "replicates": [42408.163265306124], "unit": "score", "name": "RegExp", "value": 21.481359480269475}, {"lowerIsBetter": false, "replicates": [581.0575246949448], "unit": "score", "name": "Splay", "value": 140.246011}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 18974.217508540944}]} 11:18:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "18974.22"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1508.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6591.64"}}} 11:18:41 INFO - Return code: 0 11:18:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 11:18:41 INFO - # TBPL SUCCESS # 11:18:41 INFO - Running post-action listener: _resource_record_post_action 11:18:41 INFO - Running post-run listener: _resource_record_post_run 11:18:42 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 10436608; Write bytes: 445358080; Read time: 2056; Write time: 555180 11:18:42 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 84369408; Read time: 0; Write time: 74372 11:18:42 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 8675328; Write bytes: 360988672; Read time: 2012; Write time: 480808 11:18:42 INFO - Running post-run listener: _upload_blobber_files 11:18:42 INFO - Blob upload gear active. 11:18:42 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 11:18:42 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 11:18:42 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 11:18:42 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 11:18:42 INFO - (blobuploader) - INFO - Open directory for files ... 11:18:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 11:18:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:18:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:18:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:18:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:18:43 INFO - (blobuploader) - INFO - Done attempting. 11:18:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:18:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:18:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:18:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:18:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:18:44 INFO - (blobuploader) - INFO - Done attempting. 11:18:44 INFO - (blobuploader) - INFO - Iteration through files over. 11:18:44 INFO - Return code: 0 11:18:44 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 11:18:44 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 11:18:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0fcbba32fc8ec99c435d1d192f66ac6c1d686174fe38b1e47f6237e46950ec8d1d69118ab92075605925f1f2ba1810a075d6cbea6635ff31f5b4afd939ba656b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/50d815179d58dbc326ea0fa63b68a17162cfe4b71b6e33855dacd54bed7652b4e59043269a998f46198abafc032dfaad374c4533c155da0f06d30acef35a9274"} 11:18:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 11:18:44 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 11:18:44 INFO - Contents: 11:18:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0fcbba32fc8ec99c435d1d192f66ac6c1d686174fe38b1e47f6237e46950ec8d1d69118ab92075605925f1f2ba1810a075d6cbea6635ff31f5b4afd939ba656b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/50d815179d58dbc326ea0fa63b68a17162cfe4b71b6e33855dacd54bed7652b4e59043269a998f46198abafc032dfaad374c4533c155da0f06d30acef35a9274"} 11:18:44 INFO - Copying logs to upload dir... 11:18:44 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1274.482789 ========= master_lag: 0.16 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-01-08 11:18:44.779382) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 11:18:44.782448) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0fcbba32fc8ec99c435d1d192f66ac6c1d686174fe38b1e47f6237e46950ec8d1d69118ab92075605925f1f2ba1810a075d6cbea6635ff31f5b4afd939ba656b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/50d815179d58dbc326ea0fa63b68a17162cfe4b71b6e33855dacd54bed7652b4e59043269a998f46198abafc032dfaad374c4533c155da0f06d30acef35a9274"} build_url:https://queue.taskcluster.net/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/fUwbbSMvSLOaAoB8aOYlCA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/0fcbba32fc8ec99c435d1d192f66ac6c1d686174fe38b1e47f6237e46950ec8d1d69118ab92075605925f1f2ba1810a075d6cbea6635ff31f5b4afd939ba656b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/50d815179d58dbc326ea0fa63b68a17162cfe4b71b6e33855dacd54bed7652b4e59043269a998f46198abafc032dfaad374c4533c155da0f06d30acef35a9274"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-08 11:18:44.806886) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 11:18:44.807229) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452279360.873441-1404558562 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-08 11:18:44.890362) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 11:18:44.890682) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-08 11:18:44.890989) ========= ========= Total master_lag: 0.35 =========