builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1452777089.19 results: success (0) buildid: 20160114023006 builduid: 5e5d9b44991e4f359bc89602a2a91fff revision: b4b8a8dd9ce8c2dad00cf8b134b2fe856ec572a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:29.189440) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:29.189944) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:29.190277) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006380 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:29.220991) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:29.221273) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:29.252099) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:29.252367) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023965 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:29.307269) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:29.307726) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:29.308109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:29.308384) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 05:11: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-01-14 05:11:29 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.188712 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:29.514848) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:29.515134) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.078818 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:29.605357) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:29.605720) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b4b8a8dd9ce8c2dad00cf8b134b2fe856ec572a4 --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/fx-team --rev b4b8a8dd9ce8c2dad00cf8b134b2fe856ec572a4 --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=aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 05:11:29,672 truncating revision to first 12 chars 2016-01-14 05:11:29,672 Setting DEBUG logging. 2016-01-14 05:11:29,672 attempt 1/10 2016-01-14 05:11:29,672 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b4b8a8dd9ce8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-14 05:11:29,944 unpacking tar archive at: fx-team-b4b8a8dd9ce8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567363 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:30.183657) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:30.183927) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:30.193181) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:30.193481) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:30.193942) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-14 05:11:30.194247) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:11:30 INFO - MultiFileLogger online at 20160114 05:11:30 in /builds/slave/test-pgo 05:11:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:11:30 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:11:30 INFO - {'append_to_log': False, 05:11:30 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:11:30 INFO - 'blob_upload_branch': 'Fx-Team', 05:11:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:11:30 INFO - 'branch': 'Fx-Team', 05:11:30 INFO - 'buildbot_json_path': 'buildprops.json', 05:11:30 INFO - 'config_files': ('talos/linux_config.py',), 05:11:30 INFO - 'default_actions': ('clobber', 05:11:30 INFO - 'read-buildbot-config', 05:11:30 INFO - 'download-and-extract', 05:11:30 INFO - 'populate-webroot', 05:11:30 INFO - 'create-virtualenv', 05:11:30 INFO - 'install', 05:11:30 INFO - 'run-tests'), 05:11:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:11:30 INFO - 'download_minidump_stackwalk': True, 05:11:30 INFO - 'download_symbols': 'ondemand', 05:11:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:11:30 INFO - 'tooltool.py': '/tools/tooltool.py', 05:11:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:11:30 INFO - '/tools/misc-python/virtualenv.py')}, 05:11:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:11:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:11:30 INFO - 'installer_path': 'installer.exe', 05:11:30 INFO - 'log_level': 'info', 05:11:30 INFO - 'log_name': 'talos', 05:11:30 INFO - 'log_to_console': True, 05:11:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:11:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:11:30 INFO - 'opt_config_files': (), 05:11:30 INFO - 'pip_index': False, 05:11:30 INFO - 'sps_profile': False, 05:11:30 INFO - 'sps_profile_interval': 0, 05:11:30 INFO - 'suite': 'dromaeojs', 05:11:30 INFO - 'system_bits': '32', 05:11:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:11:30 INFO - 'title': 'talos-linux64-ix-037', 05:11:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:11:30 INFO - 'use_talos_json': True, 05:11:30 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:11:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:11:30 INFO - 'work_dir': 'build'} 05:11:30 INFO - ##### 05:11:30 INFO - ##### Running clobber step. 05:11:30 INFO - ##### 05:11:30 INFO - Running pre-action listener: _resource_record_pre_action 05:11:30 INFO - Running main action method: clobber 05:11:30 INFO - rmtree: /builds/slave/test-pgo/build 05:11:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:11:31 INFO - Running post-action listener: _resource_record_post_action 05:11:31 INFO - ##### 05:11:31 INFO - ##### Running read-buildbot-config step. 05:11:31 INFO - ##### 05:11:31 INFO - Running pre-action listener: _resource_record_pre_action 05:11:31 INFO - Running main action method: read_buildbot_config 05:11:31 INFO - Using buildbot properties: 05:11:31 INFO - { 05:11:31 INFO - "project": "", 05:11:31 INFO - "product": "firefox", 05:11:31 INFO - "script_repo_revision": "production", 05:11:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:11:31 INFO - "repository": "", 05:11:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:11:31 INFO - "buildid": "20160114023006", 05:11:31 INFO - "pgo_build": "True", 05:11:31 INFO - "basedir": "/builds/slave/test-pgo", 05:11:31 INFO - "buildnumber": 417, 05:11:31 INFO - "slavename": "talos-linux64-ix-037", 05:11:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:11:31 INFO - "platform": "ubuntu64_hw", 05:11:31 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:11:31 INFO - "branch": "fx-team", 05:11:31 INFO - "repo_path": "integration/fx-team", 05:11:31 INFO - "revision": "b4b8a8dd9ce8c2dad00cf8b134b2fe856ec572a4", 05:11:31 INFO - "stage_platform": "linux64-pgo", 05:11:31 INFO - "builduid": "5e5d9b44991e4f359bc89602a2a91fff", 05:11:31 INFO - "slavebuilddir": "test" 05:11:31 INFO - } 05:11:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:11:31 INFO - Running post-action listener: _resource_record_post_action 05:11:31 INFO - ##### 05:11:31 INFO - ##### Running download-and-extract step. 05:11:31 INFO - ##### 05:11:31 INFO - Running pre-action listener: _resource_record_pre_action 05:11:31 INFO - Running main action method: download_and_extract 05:11:31 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:11: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')]} 05:11:31 INFO - https://queue.taskcluster.net/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:11:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/test_packages.json 05:11:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/test_packages.json 05:11:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:11:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:11:35 INFO - Downloaded 1448 bytes. 05:11:35 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:11:35 INFO - Using the following test package requirements: 05:11:35 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:35 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:11:35 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:11:35 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:35 INFO - u'jsshell-linux-x86_64.zip'], 05:11:35 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:11:35 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:35 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:11:35 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:11:35 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:11:35 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:35 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:35 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:11:35 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:11: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')]} 05:11:35 INFO - https://queue.taskcluster.net/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:11:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:11:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/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 05:11:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/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 05:11:39 INFO - Downloaded 24030981 bytes. 05:11:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:11:39 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:11:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:11:40 INFO - Return code: 0 05:11:40 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 05:11:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:40 INFO - https://queue.taskcluster.net/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/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 05:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/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 05:11:48 INFO - Downloaded 24030981 bytes. 05:11:48 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 05:11:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:11:48 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 05:11:49 INFO - Return code: 0 05:11: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')]} 05:11:49 INFO - https://queue.taskcluster.net/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:11:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/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 05:11:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/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 05:11:51 INFO - Downloaded 11132144 bytes. 05:11:51 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 05:11:51 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:51 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 05:11:52 INFO - Return code: 0 05:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:52 INFO - https://queue.taskcluster.net/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:11:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:11:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:11:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/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 05:11:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/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 05:11:55 INFO - Downloaded 55874894 bytes. 05:11:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:11:55 INFO - mkdir: /builds/slave/test-pgo/properties 05:11:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:11:55 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:11:55 INFO - Contents: 05:11:55 INFO - build_url:https://queue.taskcluster.net/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:11:55 INFO - Running post-action listener: _resource_record_post_action 05:11:55 INFO - Running post-action listener: set_extra_try_arguments 05:11:55 INFO - ##### 05:11:55 INFO - ##### Running populate-webroot step. 05:11:55 INFO - ##### 05:11:55 INFO - Running pre-action listener: _resource_record_pre_action 05:11:55 INFO - Running main action method: populate_webroot 05:11:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:55 INFO - '--tppagecycles', 05:11:55 INFO - '7'], 05:11:55 INFO - 'tests': ['tsvgm']}}, 05:11:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:11:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:11:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:11:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:11:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:11:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:11:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:55 INFO - 'talos_options': ['--e10s'], 05:11:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:55 INFO - 'tests': ['damp', 'tps']}, 05:11:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:55 INFO - 'talos_options': ['--e10s'], 05:11:55 INFO - 'tests': ['damp', 'tps']}, 05:11:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:11:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:55 INFO - 'other': {'tests': ['a11yr', 05:11:55 INFO - 'ts_paint', 05:11:55 INFO - 'tpaint', 05:11:55 INFO - 'sessionrestore', 05:11:55 INFO - 'sessionrestore_no_auto_restore']}, 05:11:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:11:55 INFO - 'tests': ['a11yr', 05:11:55 INFO - 'ts_paint', 05:11:55 INFO - 'tpaint', 05:11:55 INFO - 'sessionrestore', 05:11:55 INFO - 'sessionrestore_no_auto_restore']}, 05:11:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:11:55 INFO - 'tests': ['a11yr', 05:11:55 INFO - 'ts_paint', 05:11:55 INFO - 'tpaint', 05:11:55 INFO - 'sessionrestore', 05:11:55 INFO - 'sessionrestore_no_auto_restore']}, 05:11:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:11:55 INFO - 'tests': ['a11yr', 05:11:55 INFO - 'ts_paint', 05:11:55 INFO - 'tpaint', 05:11:55 INFO - 'sessionrestore', 05:11:55 INFO - 'sessionrestore_no_auto_restore']}, 05:11:55 INFO - 'other_l64': {'tests': ['a11yr', 05:11:55 INFO - 'ts_paint', 05:11:55 INFO - 'tpaint', 05:11:55 INFO - 'sessionrestore', 05:11:55 INFO - 'sessionrestore_no_auto_restore']}, 05:11:55 INFO - 'other_nol64': {'tests': ['a11yr', 05:11:55 INFO - 'ts_paint', 05:11:55 INFO - 'tpaint', 05:11:55 INFO - 'sessionrestore', 05:11:55 INFO - 'sessionrestore_no_auto_restore']}, 05:11:55 INFO - 'svgr': {'tests': ['tsvgx', 05:11:55 INFO - 'tsvgr_opacity', 05:11:55 INFO - 'tart', 05:11:55 INFO - 'tscrollx', 05:11:55 INFO - 'cart']}, 05:11:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:11:55 INFO - 'tests': ['tsvgx', 05:11:55 INFO - 'tsvgr_opacity', 05:11:55 INFO - 'tart', 05:11:55 INFO - 'tscrollx', 05:11:55 INFO - 'cart']}, 05:11:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:55 INFO - 'tests': ['tp5o']}, 05:11:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:55 INFO - 'talos_options': ['--e10s'], 05:11:55 INFO - 'tests': ['tp5o']}, 05:11:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:55 INFO - 'talos_options': ['--xperf_path', 05:11:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:55 INFO - 'tests': ['tp5n']}, 05:11:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:55 INFO - 'talos_options': ['--e10s', 05:11:55 INFO - '--xperf_path', 05:11:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:55 INFO - 'tests': ['tp5n']}}, 05:11:55 INFO - 'talos.zip': {'path': '', 05:11:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:55 INFO - Running post-action listener: _resource_record_post_action 05:11:55 INFO - ##### 05:11:55 INFO - ##### Running create-virtualenv step. 05:11:55 INFO - ##### 05:11:55 INFO - Running pre-action listener: _resource_record_pre_action 05:11:55 INFO - Running main action method: create_virtualenv 05:11:55 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:11:55 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 05:11:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:11:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:55 INFO - Using real prefix '/usr' 05:11:55 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:11:56 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:58 INFO - Installing pip.................done. 05:11:58 INFO - Return code: 0 05:11:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb894b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2050840>, '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 0x1fbd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', '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 05:11:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:11:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:11:58 INFO - Using env: {'DISPLAY': ':0', 05:11:58 INFO - 'HOME': '/home/cltbld', 05:11:58 INFO - 'LANG': 'en_US.UTF-8', 05:11:58 INFO - 'LANGUAGE': 'en_US:en', 05:11:58 INFO - 'LOGNAME': 'cltbld', 05:11:58 INFO - 'MAIL': '/var/mail/cltbld', 05:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:58 INFO - 'MOZ_NO_REMOTE': '1', 05:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:58 INFO - 'NO_EM_RESTART': '1', 05:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:11:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:11:58 INFO - 'SHELL': '/bin/bash', 05:11:58 INFO - 'SHLVL': '1', 05:11:58 INFO - 'TERM': 'linux', 05:11:58 INFO - 'TMOUT': '86400', 05:11:58 INFO - 'USER': 'cltbld', 05:11:58 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', 05:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:58 INFO - '_': '/tools/buildbot/bin/python'} 05:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:58 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 05:11:58 INFO - Cleaning up... 05:11:58 INFO - Return code: 0 05:11:58 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:58 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbb894b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2050840>, '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 0x1fbd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', '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 05:11:58 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:11:58 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:11:58 INFO - Using env: {'DISPLAY': ':0', 05:11:58 INFO - 'HOME': '/home/cltbld', 05:11:58 INFO - 'LANG': 'en_US.UTF-8', 05:11:58 INFO - 'LANGUAGE': 'en_US:en', 05:11:58 INFO - 'LOGNAME': 'cltbld', 05:11:58 INFO - 'MAIL': '/var/mail/cltbld', 05:11:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:58 INFO - 'MOZ_NO_REMOTE': '1', 05:11:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:58 INFO - 'NO_EM_RESTART': '1', 05:11:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:11:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:11:58 INFO - 'SHELL': '/bin/bash', 05:11:58 INFO - 'SHLVL': '1', 05:11:58 INFO - 'TERM': 'linux', 05:11:58 INFO - 'TMOUT': '86400', 05:11:58 INFO - 'USER': 'cltbld', 05:11:58 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', 05:11:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:58 INFO - '_': '/tools/buildbot/bin/python'} 05:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:58 INFO - Downloading/unpacking psutil>=0.7.1 05:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:00 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:12:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:12:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:12:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:12:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:12:00 INFO - Installing collected packages: psutil 05:12:00 INFO - Running setup.py install for psutil 05:12:00 INFO - building 'psutil._psutil_linux' extension 05:12:00 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 05:12:00 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 05:12:00 INFO - building 'psutil._psutil_posix' extension 05:12:00 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 05:12:00 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 05:12:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:12:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:12:00 INFO - Successfully installed psutil 05:12:00 INFO - Cleaning up... 05:12:00 INFO - Return code: 0 05:12:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:12: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')]} 05:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12: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')]} 05:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12: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', '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 0x7fbb894b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2050840>, '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 0x1fbd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', '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 05:12: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:12: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 mozsystemmonitor==0.0.0 05:12:01 INFO - Using env: {'DISPLAY': ':0', 05:12:01 INFO - 'HOME': '/home/cltbld', 05:12:01 INFO - 'LANG': 'en_US.UTF-8', 05:12:01 INFO - 'LANGUAGE': 'en_US:en', 05:12:01 INFO - 'LOGNAME': 'cltbld', 05:12:01 INFO - 'MAIL': '/var/mail/cltbld', 05:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:01 INFO - 'MOZ_NO_REMOTE': '1', 05:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:01 INFO - 'NO_EM_RESTART': '1', 05:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:12:01 INFO - 'PWD': '/builds/slave/test-pgo', 05:12:01 INFO - 'SHELL': '/bin/bash', 05:12:01 INFO - 'SHLVL': '1', 05:12:01 INFO - 'TERM': 'linux', 05:12:01 INFO - 'TMOUT': '86400', 05:12:01 INFO - 'USER': 'cltbld', 05:12:01 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', 05:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:01 INFO - '_': '/tools/buildbot/bin/python'} 05:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:12: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 05:12: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 05:12: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 05:12: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 05:12: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 05:12: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 05:12:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:12:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:12:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:12:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:12:02 INFO - Installing collected packages: mozsystemmonitor 05:12:02 INFO - Running setup.py install for mozsystemmonitor 05:12:03 INFO - Successfully installed mozsystemmonitor 05:12:03 INFO - Cleaning up... 05:12:03 INFO - Return code: 0 05:12:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbb894b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2050840>, '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 0x1fbd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', '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 05:12:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:12:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:12:03 INFO - Using env: {'DISPLAY': ':0', 05:12:03 INFO - 'HOME': '/home/cltbld', 05:12:03 INFO - 'LANG': 'en_US.UTF-8', 05:12:03 INFO - 'LANGUAGE': 'en_US:en', 05:12:03 INFO - 'LOGNAME': 'cltbld', 05:12:03 INFO - 'MAIL': '/var/mail/cltbld', 05:12:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:03 INFO - 'MOZ_NO_REMOTE': '1', 05:12:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:03 INFO - 'NO_EM_RESTART': '1', 05:12:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:12:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:12:03 INFO - 'SHELL': '/bin/bash', 05:12:03 INFO - 'SHLVL': '1', 05:12:03 INFO - 'TERM': 'linux', 05:12:03 INFO - 'TMOUT': '86400', 05:12:03 INFO - 'USER': 'cltbld', 05:12:03 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', 05:12:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:03 INFO - '_': '/tools/buildbot/bin/python'} 05:12:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:03 INFO - Downloading/unpacking blobuploader==1.2.4 05:12: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 05:12: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 05:12: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 05:12: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 05:12: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 05:12: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 05:12:05 INFO - Downloading blobuploader-1.2.4.tar.gz 05:12:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:12:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:12:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:12:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:12:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:05 INFO - Downloading docopt-0.6.1.tar.gz 05:12:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:12:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:12:05 INFO - Installing collected packages: blobuploader, requests, docopt 05:12:05 INFO - Running setup.py install for blobuploader 05:12:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:12:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:12:05 INFO - Running setup.py install for requests 05:12:06 INFO - Running setup.py install for docopt 05:12:06 INFO - Successfully installed blobuploader requests docopt 05:12:06 INFO - Cleaning up... 05:12:06 INFO - Return code: 0 05:12:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:12:06 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')]} 05:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:06 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')]} 05:12:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:06 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 0x7fbb894b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2050840>, '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 0x1fbd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', '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 05:12:06 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 05:12:06 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 05:12:06 INFO - Using env: {'DISPLAY': ':0', 05:12:06 INFO - 'HOME': '/home/cltbld', 05:12:06 INFO - 'LANG': 'en_US.UTF-8', 05:12:06 INFO - 'LANGUAGE': 'en_US:en', 05:12:06 INFO - 'LOGNAME': 'cltbld', 05:12:06 INFO - 'MAIL': '/var/mail/cltbld', 05:12:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:06 INFO - 'MOZ_NO_REMOTE': '1', 05:12:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:06 INFO - 'NO_EM_RESTART': '1', 05:12:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:12:06 INFO - 'PWD': '/builds/slave/test-pgo', 05:12:06 INFO - 'SHELL': '/bin/bash', 05:12:06 INFO - 'SHLVL': '1', 05:12:06 INFO - 'TERM': 'linux', 05:12:06 INFO - 'TMOUT': '86400', 05:12:06 INFO - 'USER': 'cltbld', 05:12:06 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', 05:12:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:06 INFO - '_': '/tools/buildbot/bin/python'} 05:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:12:06 INFO - Running setup.py (path:/tmp/pip-PBYYFq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:12:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:12:06 INFO - Running setup.py (path:/tmp/pip-xUlooV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:12:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:12:06 INFO - Running setup.py (path:/tmp/pip-eQaicK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:12:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:12:06 INFO - Running setup.py (path:/tmp/pip-ArdoX5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:12:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:12:06 INFO - Running setup.py (path:/tmp/pip-VSVOm9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:12:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:12:06 INFO - Running setup.py (path:/tmp/pip-I4iPW1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:12:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:12:07 INFO - Running setup.py (path:/tmp/pip-PbnBr0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:12:07 INFO - Running setup.py (path:/tmp/pip-7Y194U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:12:07 INFO - Running setup.py (path:/tmp/pip-QQlqdR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:12:07 INFO - Running setup.py (path:/tmp/pip-SW8WHj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:12:07 INFO - Running setup.py (path:/tmp/pip-hi0fRj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:12:07 INFO - Running setup.py (path:/tmp/pip-jNgZ6c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:12:07 INFO - Running setup.py (path:/tmp/pip-cYzh4E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:12:07 INFO - Running setup.py (path:/tmp/pip-bxL9bu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:12:07 INFO - Running setup.py (path:/tmp/pip-ODcI6K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:12:07 INFO - Running setup.py (path:/tmp/pip-GDdgHt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:12:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:12:07 INFO - Running setup.py (path:/tmp/pip-PIECK_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:12:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:12:07 INFO - Running setup.py install for manifestparser 05:12:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:12:07 INFO - Running setup.py install for mozcrash 05:12:07 INFO - Running setup.py install for mozdebug 05:12:08 INFO - Running setup.py install for mozdevice 05:12:08 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:12:08 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:12:08 INFO - Running setup.py install for mozfile 05:12:08 INFO - Running setup.py install for mozhttpd 05:12:08 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:12:08 INFO - Running setup.py install for mozinfo 05:12:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:12:08 INFO - Running setup.py install for mozInstall 05:12:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:12:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:12:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:12:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:12:08 INFO - Running setup.py install for mozleak 05:12:08 INFO - Running setup.py install for mozlog 05:12:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:12:08 INFO - Running setup.py install for moznetwork 05:12:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:12:08 INFO - Running setup.py install for mozprocess 05:12:09 INFO - Running setup.py install for mozprofile 05:12:09 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:12:09 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:12:09 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:12:09 INFO - Running setup.py install for mozrunner 05:12:09 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:12:09 INFO - Running setup.py install for mozscreenshot 05:12:09 INFO - Running setup.py install for moztest 05:12:09 INFO - Running setup.py install for mozversion 05:12:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:12:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:12:09 INFO - Cleaning up... 05:12:09 INFO - Return code: 0 05:12:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7fbb894b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2050840>, '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 0x1fbd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', '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 05:12:09 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 05:12:09 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 05:12:09 INFO - Using env: {'DISPLAY': ':0', 05:12:09 INFO - 'HOME': '/home/cltbld', 05:12:09 INFO - 'LANG': 'en_US.UTF-8', 05:12:09 INFO - 'LANGUAGE': 'en_US:en', 05:12:09 INFO - 'LOGNAME': 'cltbld', 05:12:09 INFO - 'MAIL': '/var/mail/cltbld', 05:12:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:09 INFO - 'MOZ_NO_REMOTE': '1', 05:12:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:09 INFO - 'NO_EM_RESTART': '1', 05:12:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:12:09 INFO - 'PWD': '/builds/slave/test-pgo', 05:12:09 INFO - 'SHELL': '/bin/bash', 05:12:09 INFO - 'SHLVL': '1', 05:12:09 INFO - 'TERM': 'linux', 05:12:09 INFO - 'TMOUT': '86400', 05:12:09 INFO - 'USER': 'cltbld', 05:12:09 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', 05:12:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:09 INFO - '_': '/tools/buildbot/bin/python'} 05:12:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:12:09 INFO - Running setup.py (path:/tmp/pip-_TJwCe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:12:09 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)) 05:12:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:12:09 INFO - Running setup.py (path:/tmp/pip-M8RBvk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:12:09 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)) 05:12:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:12:09 INFO - Running setup.py (path:/tmp/pip-loWKQF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:12:10 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)) 05:12:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:12:10 INFO - Running setup.py (path:/tmp/pip-BYnl9G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:12:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:12:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:12:10 INFO - Running setup.py (path:/tmp/pip-RwsJnq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:12:10 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)) 05:12:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:12:10 INFO - Running setup.py (path:/tmp/pip-A9unir-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:12:10 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)) 05:12:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:12:10 INFO - Running setup.py (path:/tmp/pip-qNtpHL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:12:10 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)) 05:12:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:12:10 INFO - Running setup.py (path:/tmp/pip-1BIxDm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:12:10 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)) 05:12:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:12:10 INFO - Running setup.py (path:/tmp/pip-gtQ2LH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:12:10 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)) 05:12:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:12:10 INFO - Running setup.py (path:/tmp/pip-ohDiy5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:12:10 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)) 05:12:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:12:10 INFO - Running setup.py (path:/tmp/pip-KvP5TF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:12:10 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)) 05:12:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:12:10 INFO - Running setup.py (path:/tmp/pip-K_buG_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:12:10 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)) 05:12:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:12:10 INFO - Running setup.py (path:/tmp/pip-UMV5dr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:12:10 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)) 05:12:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:12:10 INFO - Running setup.py (path:/tmp/pip-RKaWdi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:12:10 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)) 05:12:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:12:10 INFO - Running setup.py (path:/tmp/pip-vzQcXZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:12:10 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)) 05:12:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:12:10 INFO - Running setup.py (path:/tmp/pip-Qol_E7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:12:11 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)) 05:12:11 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:12:11 INFO - Running setup.py (path:/tmp/pip-pA0xWd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:12:11 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)) 05:12:11 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)) 05:12:11 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)) 05:12:11 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)) 05:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:12:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:12:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:12 INFO - Downloading blessings-1.5.1.tar.gz 05:12:12 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 05:12:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:12:12 INFO - Installing collected packages: blessings 05:12:12 INFO - Running setup.py install for blessings 05:12:12 INFO - Successfully installed blessings 05:12:12 INFO - Cleaning up... 05:12:13 INFO - Return code: 0 05:12:13 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:12:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:12:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:12:13 INFO - Reading from file tmpfile_stdout 05:12:13 INFO - Current package versions: 05:12:13 INFO - argparse == 1.2.1 05:12:13 INFO - blessings == 1.5.1 05:12:13 INFO - blobuploader == 1.2.4 05:12:13 INFO - docopt == 0.6.1 05:12:13 INFO - manifestparser == 1.1 05:12:13 INFO - mozInstall == 1.12 05:12:13 INFO - mozcrash == 0.16 05:12:13 INFO - mozdebug == 0.1 05:12:13 INFO - mozdevice == 0.48 05:12:13 INFO - mozfile == 1.2 05:12:13 INFO - mozhttpd == 0.7 05:12:13 INFO - mozinfo == 0.9 05:12:13 INFO - mozleak == 0.1 05:12:13 INFO - mozlog == 3.1 05:12:13 INFO - moznetwork == 0.27 05:12:13 INFO - mozprocess == 0.22 05:12:13 INFO - mozprofile == 0.28 05:12:13 INFO - mozrunner == 6.11 05:12:13 INFO - mozscreenshot == 0.1 05:12:13 INFO - mozsystemmonitor == 0.0 05:12:13 INFO - moztest == 0.7 05:12:13 INFO - mozversion == 1.4 05:12:13 INFO - psutil == 3.1.1 05:12:13 INFO - requests == 1.2.3 05:12:13 INFO - wsgiref == 0.1.2 05:12:13 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:13 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 0x7fbb894b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2050840>, '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 0x1fbd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', '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 05:12:13 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 05:12:13 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 05:12:13 INFO - Using env: {'DISPLAY': ':0', 05:12:13 INFO - 'HOME': '/home/cltbld', 05:12:13 INFO - 'LANG': 'en_US.UTF-8', 05:12:13 INFO - 'LANGUAGE': 'en_US:en', 05:12:13 INFO - 'LOGNAME': 'cltbld', 05:12:13 INFO - 'MAIL': '/var/mail/cltbld', 05:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:13 INFO - 'MOZ_NO_REMOTE': '1', 05:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:13 INFO - 'NO_EM_RESTART': '1', 05:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:12:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:12:13 INFO - 'SHELL': '/bin/bash', 05:12:13 INFO - 'SHLVL': '1', 05:12:13 INFO - 'TERM': 'linux', 05:12:13 INFO - 'TMOUT': '86400', 05:12:13 INFO - 'USER': 'cltbld', 05:12:13 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', 05:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:13 INFO - '_': '/tools/buildbot/bin/python'} 05:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:13 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)) 05:12:13 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)) 05:12:13 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)) 05:12:13 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)) 05:12:13 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)) 05:12:13 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)) 05:12:13 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)) 05:12:13 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)) 05:12:13 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)) 05:12:13 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)) 05:12:13 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)) 05:12:13 INFO - Cleaning up... 05:12:13 INFO - Return code: 0 05:12:13 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:13 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 0x7fbb894b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2050840>, '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 0x1fbd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', '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 05:12:13 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 05:12:13 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 05:12:13 INFO - Using env: {'DISPLAY': ':0', 05:12:13 INFO - 'HOME': '/home/cltbld', 05:12:13 INFO - 'LANG': 'en_US.UTF-8', 05:12:13 INFO - 'LANGUAGE': 'en_US:en', 05:12:13 INFO - 'LOGNAME': 'cltbld', 05:12:13 INFO - 'MAIL': '/var/mail/cltbld', 05:12:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:13 INFO - 'MOZ_NO_REMOTE': '1', 05:12:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:13 INFO - 'NO_EM_RESTART': '1', 05:12:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:12:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:12:13 INFO - 'SHELL': '/bin/bash', 05:12:13 INFO - 'SHLVL': '1', 05:12:13 INFO - 'TERM': 'linux', 05:12:13 INFO - 'TMOUT': '86400', 05:12:13 INFO - 'USER': 'cltbld', 05:12:13 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', 05:12:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:13 INFO - '_': '/tools/buildbot/bin/python'} 05:12:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:13 INFO - Downloading/unpacking jsonschema 05:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:12:15 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 05:12:15 INFO - Downloading/unpacking functools32 (from jsonschema) 05:12:15 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 05:12:15 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 05:12:15 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 05:12:15 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 05:12:15 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 05:12:15 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 05:12:15 INFO - Downloading functools32-3.2.3-2.tar.gz 05:12:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:12:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:12:15 INFO - warning: no files found matching '*.txt' 05:12:15 INFO - no previously-included directories found matching 'build' 05:12:15 INFO - no previously-included directories found matching 'dist' 05:12:15 INFO - no previously-included directories found matching '.git*' 05:12:15 INFO - Installing collected packages: jsonschema, functools32 05:12:15 INFO - Running setup.py install for functools32 05:12:15 INFO - warning: no files found matching '*.txt' 05:12:15 INFO - no previously-included directories found matching 'build' 05:12:15 INFO - no previously-included directories found matching 'dist' 05:12:15 INFO - no previously-included directories found matching '.git*' 05:12:15 INFO - Successfully installed jsonschema functools32 05:12:15 INFO - Cleaning up... 05:12:15 INFO - Return code: 0 05:12:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:12:15 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')]} 05:12:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:15 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')]} 05:12:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:15 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 0x7fbb894b7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1eef8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fbf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2050840>, '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 0x1fbd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdb60>, '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': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', '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 05:12:15 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 05:12:15 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 05:12:15 INFO - Using env: {'DISPLAY': ':0', 05:12:15 INFO - 'HOME': '/home/cltbld', 05:12:15 INFO - 'LANG': 'en_US.UTF-8', 05:12:15 INFO - 'LANGUAGE': 'en_US:en', 05:12:15 INFO - 'LOGNAME': 'cltbld', 05:12:15 INFO - 'MAIL': '/var/mail/cltbld', 05:12:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:15 INFO - 'MOZ_NO_REMOTE': '1', 05:12:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:15 INFO - 'NO_EM_RESTART': '1', 05:12:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:12:15 INFO - 'PWD': '/builds/slave/test-pgo', 05:12:15 INFO - 'SHELL': '/bin/bash', 05:12:15 INFO - 'SHLVL': '1', 05:12:15 INFO - 'TERM': 'linux', 05:12:15 INFO - 'TMOUT': '86400', 05:12:15 INFO - 'USER': 'cltbld', 05:12:15 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', 05:12:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:15 INFO - '_': '/tools/buildbot/bin/python'} 05:12:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:16 INFO - Downloading/unpacking flake8 05:12:16 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 05:12:16 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 05:12:16 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 05:12:16 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 05:12:16 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 05:12:16 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 05:12:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:12:17 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 05:12:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:12:17 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 05:12:17 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 05:12:17 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 05:12:17 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 05:12:17 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 05:12:17 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 05:12:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:12:17 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 05:12:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:12:17 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 05:12:17 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 05:12:17 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 05:12:17 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 05:12:17 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 05:12:17 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 05:12:18 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 05:12:18 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:12:18 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 05:12:18 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 05:12:18 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 05:12:18 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 05:12:18 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 05:12:18 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 05:12:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:12:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:12:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:12:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:12:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:12:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:12:18 INFO - no previously-included directories found matching 'docs/_build' 05:12:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:12:18 INFO - Running setup.py install for pep8 05:12:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:12:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:12:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:12:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:12:18 INFO - no previously-included directories found matching 'docs/_build' 05:12:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:12:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:12:18 INFO - Cleaning up... 05:12:18 INFO - Return code: 0 05:12:18 INFO - Running post-action listener: _resource_record_post_action 05:12:18 INFO - Running post-action listener: _start_resource_monitoring 05:12:18 INFO - Starting resource monitoring. 05:12:18 INFO - ##### 05:12:18 INFO - ##### Running install step. 05:12:18 INFO - ##### 05:12:18 INFO - Running pre-action listener: _resource_record_pre_action 05:12:18 INFO - Running main action method: install 05:12:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:12:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:12:18 INFO - Reading from file tmpfile_stdout 05:12:18 INFO - Detecting whether we're running mozinstall >=1.0... 05:12:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:12:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:12:18 INFO - Reading from file tmpfile_stdout 05:12:18 INFO - Output received: 05:12:18 INFO - Usage: mozinstall [options] installer 05:12:18 INFO - Options: 05:12:18 INFO - -h, --help show this help message and exit 05:12:18 INFO - -d DEST, --destination=DEST 05:12:18 INFO - Directory to install application into. [default: 05:12:18 INFO - "/builds/slave/test-pgo"] 05:12:18 INFO - --app=APP Application being installed. [default: firefox] 05:12:18 INFO - mkdir: /builds/slave/test-pgo/build/application 05:12:18 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'] 05:12:18 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 05:12:35 INFO - Reading from file tmpfile_stdout 05:12:35 INFO - Output received: 05:12:35 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:12:35 INFO - Running post-action listener: _resource_record_post_action 05:12:35 INFO - ##### 05:12:35 INFO - ##### Running run-tests step. 05:12:35 INFO - ##### 05:12:35 INFO - Running pre-action listener: _resource_record_pre_action 05:12:35 INFO - Running main action method: run_tests 05:12:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:12:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:12:35 INFO - Python 2.7.3 05:12:35 INFO - Return code: 0 05:12:35 INFO - grabbing minidump binary from tooltool 05:12: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')]} 05:12:35 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 0x2050840>, '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 0x1fbd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fbdb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:12:35 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 05:12:35 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 05:12:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:12:35 INFO - Return code: 0 05:12:35 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:12:35 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:12:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:12:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:12:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:12:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:12:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:12:36 INFO - Return code: 0 05:12:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 05:12:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 05:12:36 INFO - Using env: {'DISPLAY': ':0', 05:12:36 INFO - 'HOME': '/home/cltbld', 05:12:36 INFO - 'LANG': 'en_US.UTF-8', 05:12:36 INFO - 'LANGUAGE': 'en_US:en', 05:12:36 INFO - 'LOGNAME': 'cltbld', 05:12:36 INFO - 'MAIL': '/var/mail/cltbld', 05:12:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:12:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:36 INFO - 'MOZ_NO_REMOTE': '1', 05:12:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:12:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:36 INFO - 'NO_EM_RESTART': '1', 05:12:36 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:12:36 INFO - 'PWD': '/builds/slave/test-pgo', 05:12:36 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:12:36 INFO - 'SHELL': '/bin/bash', 05:12:36 INFO - 'SHLVL': '1', 05:12:36 INFO - 'TERM': 'linux', 05:12:36 INFO - 'TMOUT': '86400', 05:12:36 INFO - 'USER': 'cltbld', 05:12:36 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605', 05:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:36 INFO - '_': '/tools/buildbot/bin/python'} 05:12:36 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 05:12:36 INFO - mozversion application_buildid: 20160114023006 05:12:36 INFO - mozversion application_changeset: b4b8a8dd9ce8c2dad00cf8b134b2fe856ec572a4 05:12:36 INFO - mozversion application_display_name: Nightly 05:12:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:12:36 INFO - mozversion application_name: Firefox 05:12:36 INFO - mozversion application_remotingname: firefox 05:12:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:12:36 INFO - mozversion application_vendor: Mozilla 05:12:36 INFO - mozversion application_version: 46.0a1 05:12:36 INFO - mozversion platform_buildid: 20160114023006 05:12:36 INFO - mozversion platform_changeset: b4b8a8dd9ce8c2dad00cf8b134b2fe856ec572a4 05:12:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:12:36 INFO - mozversion platform_version: 46.0a1 05:12:36 INFO - using testdate: 1452777156 05:12:36 INFO - actual date: 1452777156 05:12:36 INFO - starting webserver on 'localhost:59393' 05:12:36 INFO - SUITE-START | Running 3 tests 05:12:36 INFO - TEST-START | dromaeo_css 05:12:36 INFO - operating with platform_type : linux_ 05:12:36 INFO - Initialising browser for dromaeo_css test... 05:12:36 INFO - TEST-INFO | started process 24862 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6aT8de/profile http://localhost:59393/getInfo.html) 05:12:40 INFO - PROCESS | 24862 | __metrics Screen width/height:1600/1200 05:12:40 INFO - PROCESS | 24862 | colorDepth:24 05:12:40 INFO - PROCESS | 24862 | Browser inner width/height: 1024/697 05:12:40 INFO - PROCESS | 24862 | __metrics 05:12:40 INFO - PROCESS | 24862 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:12:40 INFO - PROCESS | 24862 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:12:41 INFO - TEST-INFO | 24862: exit 0 05:12:41 INFO - Browser initialized. 05:12:41 INFO - Running cycle 1/1 for dromaeo_css test... 05:12:41 INFO - TEST-INFO | started process 24956 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp6aT8de/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:53 INFO - PROCESS | 24956 | RSS: Main: 149491712 05:12:53 INFO - PROCESS | 24956 | 05:13:45 INFO - PROCESS | 24956 | 1452777225024 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] 05:15:53 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:59393/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59393/tests/dromaeo/cssquery-ext.html) 05:15:54 INFO - PROCESS | 24956 | RSS: Main: 226287616 05:15:54 INFO - PROCESS | 24956 | 05:18:56 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:59393/tests/dromaeo/cssquery-ext.html (next: http://localhost:59393/tests/dromaeo/cssquery-jquery.html) 05:18:57 INFO - PROCESS | 24956 | RSS: Main: 236732416 05:18:57 INFO - PROCESS | 24956 | 05:21:59 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:59393/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59393/tests/dromaeo/cssquery-mootools.html) 05:21:59 INFO - PROCESS | 24956 | RSS: Main: 244072448 05:21:59 INFO - PROCESS | 24956 | 05:25:01 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:59393/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59393/tests/dromaeo/cssquery-prototype.html) 05:25:02 INFO - PROCESS | 24956 | RSS: Main: 212619264 05:25:02 INFO - PROCESS | 24956 | 05:28:04 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:59393/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59393/tests/dromaeo/cssquery-yui.html) 05:28:05 INFO - PROCESS | 24956 | RSS: Main: 215683072 05:28:05 INFO - PROCESS | 24956 | 05:31:07 INFO - PROCESS | 24956 | Cycle 1(1): loaded http://localhost:59393/tests/dromaeo/cssquery-yui.html (next: http://localhost:59393/tests/dromaeo/cssquery-dojo.html) 05:31:07 INFO - PROCESS | 24956 | RSS: Main: 281776128 05:31:07 INFO - PROCESS | 24956 | 05:31:07 INFO - PROCESS | 24956 | __start_tp_report 05:31:07 INFO - PROCESS | 24956 | _x_x_mozilla_page_load 05:31:07 INFO - PROCESS | 24956 | _x_x_mozilla_page_load_details 05:31:07 INFO - PROCESS | 24956 | |i|pagename|runs| 05:31:07 INFO - PROCESS | 24956 | |0;dojo.html;3171.3023134910313;3179.8887038953635;3219.726323262523;3233.1593785615746;3255.0234929521143;5009.248612708096;5104.872378190538;5126.179811230204;5151.184732657199;5186.35170603675;5095.159298715716;5152.355955505562;5182.11903976324;5186.585073194145;5219.921701174476;4671.579557839794;4709.340692303072;4726.0547890421885;4777.426708794949;4787.1622466068475;4781.952180478185;4788.640851936101;4824.2040063389495;4845.491223421543;4855.368802055727;4630;4706.270528068155;4707.340972263886;4769.332293478916;4802.615790736768;4732.526747325274;4744.359511465942;4753.786079626425;4765.880852978668;4803.159447096779;4584.977075114636;4717.622590192811;4730.763461826929;4737.384140061805;4788.7605619719225;5010.874728131789;5025.447200807908;5083.974580127113;5099.133147364957;5124.718140502271;5528.253685752412;5531.3915469298345;5531.557475401958;5534;5539.501444869981;5406.216098665711;5521.089020311684;5574.693391863487;5581.581381396411;5589.077802162638;5245.816396426145;5282;5300.761465734051;5304.999999999962;5352.116900711378;5691.345495268097;5698;5701.971490142523;5719.857003574861;5742.511886489695;5267.947320526822;5368.624196306299;5460.890782184334;5474.7810087596845;5488.313960754906;5608.298962629671;5608.915866262009;5611.158326251095;5614.242077319591;5624.21261023457;5552.7778888843995;5579.46995035471;5579.721013949286;5580.860478487989;5582.665040097607;5397.865053373697;5495.368032676293;5513.283273174462;5553.4724201200825;5597.80407685729;4301.784910754513;4308.655307575386;4310.094880075157;4318.201132790444;4354.259775838115;3853.3064048470983;3864.169203621235;3878.3019056569524;3906.824192911326;3914.9021274468364;5081.7967281309075;5153.484651534816;5172;5262.368515778131;5272.604554658339;5619.690916999604;5629.521490673257;5645.379008309083;5650.463205995424;5652.971735141298;5217.426083130853;5237.476252374732;5240.135377662643;5241.528262456321;5285.392179899284;4662.160811053975;4723.551262630044;4734.242521196592;4764.0471905619015;4794.232922732346;5770.971145144247;5787.363390027093;5788.565857560699;5799.623024503394;5799.652020878761;5403.216533602685;5604.775808967595;5623.044082506066;5625.8593535161945;5669.886602268014;5592.496675299242;5696.4588364107;5772.855678608068;5779.595428319977;5794.536437084938;5429.592780541396;5430.67415955044;5433.320834895638;5440.809571664972;5448.509634132947;5480.369757477782;5491.231227628055;5499.807506737245;5503.257060296809;5531.308586426697;5239.214117882196;5267.604929630216;5423.755930983037;5533.363663178786;5552.33371995347;5468.152436372368;5468.753906074316;5470.781168753205;5480.205370221375;5481.424450432806;5368.785248590013;5381.381141168816;5383.515483606494;5387.757550910297;5425.755840987086;5310.495502927216;5405.567554595702;5442.510174084351;5500.834974950758;5543.417941116125;5266.394364648115;5284.947150528599;5295.311609490742;5298.470152984671;5351.117065684274 05:31:07 INFO - PROCESS | 24956 | |1;ext.html;524.2005940940066;536.8899375627997;558.3272157050754;561.5563704673309;575.5999580291697;28095.719042809567;28584.142475725737;28592.428151436983;35220.2955940881;35971.820140899326;42326;43284.783576082154;43369.132617347714;43463.91340216496;43598;8524.573771311425;8748.294082653885;8753.299736021103;8757.737267881974;8762.86855697165;8489.490630562155;8599.183077607617;8640.135986401341;8641.049484556694;8643.956780216091;8326.875096873551;8393.118722534138;8400.621972011275;8407.411481196319;8408.32733381328;8560.357973152039;8664.22022018015;8666.35002374818;8669.523176225304;8674.08922063187;8412.705555305534;8531.658733650647;8535.402521823475;8554;8558.058613552505;38774.80612596947;39099;39148.80425597882;39177;39221;3263.918402039968;3362.041818081835;3399.2521645238007;3419.8461069251694;3905.49228600283;28043.158705238875;28750.424991500262;28756.281092972633;28762.568561471595;28841.278968025967;3717.8326975286177;3831.1188426661747;3848.7883166425836;3855.5373355197557;3938.5864484229314;280924;282061;282489;282865.99999999796;283531;60966.69516652388;61151.69424152851;61270.38729612736;61360.38639613636;61380;65865;66043.66978165174;66133;66170.66914665396;66184;16229.107399092927;16394.426195083113;16403.753943690856;16408.507744767678;16424.75362869558;12420.565280215329;12470.438830252479;12488.438020289108;12506.249625022529;12513.624591262276;19500.8049919499;20145.29491467821;20319.4920126998;20444.386668399973;20464;6664.566803157779;7896;8272.875906861402;8411.3270938326;8433.692777619479;935.7520257131865;953.270747877874;988.560090759605;997.4115271989562;1073.758404359013;28663.85668071688;28787.136385908456;29313.706862931525;29361.85319073391;29494.852525737235;993.6174572789383;1074.7581794096266;1075.4622688655672;1103.7626910214342;1137.852079229695;14887.404503819726;14983.475578354706;15021.624459388602;15086.698266034837;15091.24543772807;302120;310726;353747;364805;365229;47268.29097563539;47350.5264947353;47465.05069898652;47485.81285467891;47566.28650570244;1239.6590937492263;1273.7134144817342;1293.1659079893416;1303.9413226404833;1335.746208220435;25916.740832591433;27916.581251281652;30024.24939376533;30820.383592328475;31309.53035704421;43753.56246437495;50758.49241507686;51300.23049654184;51355.37801597874;51360.22959655683;269349;435070;441333;443199;443599;39937.600623993385;41370;41472.37791433191;41538;41639.37540936828;44566;44762.77618611886;44808.77595612001;45389.773051134536;46161;37123.25753484969;37466.2506749858;37693;38145.2370952585;38956.80521597374;37657.4351384724;37911.62088379081;38471.80764096162;38714.80642596769;38864.02839928911;32413;32935.67064329326;33172.17069573183;33228.50157247692;33363.49954750632;30014.24964375908;32101.83949080333;32540.674593254713;32588.83705581457;32621.510677340335;24423;24566.63150052715;24764;24944.75055249497;25037.374065648506 05:31:07 INFO - PROCESS | 24956 | |2;jquery.html;364.35145441114815;366.11400411005366;370.42583994808047;370.82756518219026;376.6008031486623;14161.150330980148;14269.539063162476;15434.922825385871;16383.754243686339;17230.224639891218;15690.686186276267;16229.26968286427;16637.1681415929;16950.406735764253;16956.83043169568;4833.299171620113;4983.576396006344;4986.551210391064;4987.8254261100865;4992.650514463989;3757.6805971492317;3887.7667339959553;4894.143524883149;5242.370915490146;5414.8917021659545;5241.554467870235;5401.351837779472;5402.297701298826;5420.647657902224;5445.101558242885;5497.038018346793;5522.530584900268;5532.972335138339;5545.1682247662975;5551.2228288039705;4934.925976110361;5108.131617625013;5109.897802043938;5328.866778330534;5329.2006199070065;12950.48198072076;13199.86800131996;17678.911605441892;20269.493262668402;20287.087081081387;2044.4786579422152;2095.078165607143;2191.430228140679;2267.535155293161;2279.908803647852;9430.669926552606;9468.100530449596;9563.043695630382;9630.3258771886;11545.769084618261;1765.1527266911826;1825;1828.2504173288887;1887.9622407551772;1918.2710569983456;56024;57581.712091439695;58442.41557584455;59034;59088.90933088014;9788.608455661693;9982.850257246148;10116.08955194036;10162.644307449204;10226.846597301046;13429.194248345131;13506.324683765772;13549.25479098659;13568.253746044062;13583.185008899498;7674.232576742281;7720.961395192988;7742.535447873146;7802.907592936994;7806.1413244543055;7339.816504587321;7379.298966598272;7399.4450416219;7429.702811887464;7432.888506672404;4049;4434.135343607965;4469.195544801967;4479.440069991251;4486.192485352668;1748.5541186997489;1751.474557632705;1782.5721826761744;1809.3757653609484;1824.852130075609;807.6850028488894;933.332667142996;947.5593848860314;951.2009911674227;974.9610015599438;13874.93062534681;14630.926845365919;15213.847861521464;15419.460318888785;15440.691186176438;908.6002159050129;919.9954000229956;921.5254144115786;925.7500474871747;926.2219735422277;9110.908890911007;9146.725598232064;9329.90670093304;9525.523723813782;9897.455639939728;361600;362530;554506;564298;568075;61367.693161533905;63129;63967.36032639707;64041.35958640447;64477.35522644714;1091.3015669971226;1103.1836441033738;1134.9659510214706;1142.5658249865164;1144.0561536732064;11804.291742495478;13654;13969.511067112602;14191.716165676422;14549.490767823076;30341.241468963453;30574.694253057183;31378.215544610655;31426.371472569965;31901.840490797396;35266.64733352736;36011.45982810312;36038.14088163284;37163.25673486569;39657.603423966546;6923.411510021705;7110.57336559808;7199.424046076406;7209.6395180241825;7434.996275502955;10233.437160956219;10739.838902416626;11033.172512061466;11051.72370690739;11358.09135269193;9464.810703786023;9469.451547329969;9532.04679532069;9582.329236953625;9615.615375384907;8965.237954773916;9261.073892610955;9528.475933823705;9563.330566860253;9812.116909478182;9060.546972651473;9131.634734610541;9436.669716559887;9975.152112070555;10210.132138768287;7003.4747393944635;7215.134183897966;7224.844024955982;7227.457940654367;7292.270772922665;8079;8807.119288071142;9066.954665226896;9078.137576930181;9226.169644731737 05:31:07 INFO - PROCESS | 24956 | |3;mootools.html;1297.805329200619;1437.7915202295667;1443.3937746146614;1568.5294411676493;1744.2238203999218;6651.068850360954;7532.133804612471;7693.653785579649;7709.460337776358;7715.074191097062;7317.59753213573;7438.516496427728;7457.66440510177;7483.438742094338;7504.249575042493;1952.8535359847997;1987.165390535971;2281.498070424504;2316.5830150572933;2346.753590872959;2364.9881750591308;2373.5608912351186;2374.192774456684;2374.287713685896;2377.8692171930625;2232.8771917544527;2279.133929106937;2279.7150356205475;2281.7147856517936;2283.5090455552054;2244.652078927769;2263.9434014149615;2326.5230627721276;2327.976720232793;2328.4528135888136;2309.6535519672016;2343.121329501437;2352.5765362234793;2359.421941624296;2366.645003249509;7709.421793365464;7711.344535714471;7751.961240193763;7752.689892404297;7780.844383112306;4655.371524844137;4732.43210814701;4754.643401744848;4769.952300476985;4774.904501909942;3054.2059064643354;3089.4747892858045;3139.8430078496212;3200.695933886277;3203.58353414057;1075.0969185883896;1842.207850624231;1895.573495963411;1899.078946710844;1936.4965109071602;9784;9823.263255255884;9832.950835245849;9857.950710246547;9868.161206297473;3985.3025720498795;4010.7593544387432;4047.7571345719352;4050.6556942660204;4167.354060120686;8082.555459449787;8089.9191008089165;8091.352691784643;8095.190480951976;8095.3523718102415;4667.743274119956;4677.32178834074;4687.789049492781;4690.577847993629;4700.2009658358165;4288.270993931039;4320.287152619845;4328.696991210585;4329.978350108229;4337.436133302651;3203.2312245061485;3254.886078987224;3257.885973990899;3553.236054248349;3614.0603443104983;1121.6018313498753;1138.066785236115;1144.2162118948547;1148.0413854431476;1152.0380482297207;1293.780057390246;1299.149057367407;1301.5444594392077;1302.6287508060348;1327.4889167670517;7179.389751871045;7255.818604534928;7292.088488938883;7295.124585049828;7300.598467084362;1078.4176544665793;1079.2175672637275;1083.090204228452;1089.6131873185063;1096.802575536411;5826.854328641818;5902.940970590325;5907.438793314628;5911.290645122613;5916.615419997686;9348.205402540723;9441.527923603793;9530.237580993504;9731.708048758548;9751.219902407933;9535.856962145574;9569.808603827885;9608.375455595364;9612.134907858186;9621.374610650286;7243.311885370881;7397;7406.296401841816;7458.105027396748;7460.253974602496;6981.127359080115;7007.964960175166;7012.403945664676;7031.261717519586;7037.049998250171;8358.916410836056;8525.573721314033;8557.828843423222;8649.740507784776;8822.2060014599;8738.606762695566;8755.430896991675;8802.207801297915;8951.865722014305;8957.14907083826;6531.412172904462;6629.701663425061;6661.3338666132995;6662.200535935719;6665.7668331358855;6429.099926010269;6576.605403675795;7054.435645148478;7278.927210727825;7320.853582928418;6743.494237932273;6773.830654233487;6883.965580172067;6918.93081069203;6994.510384273052;6585.209774827052;6718.193816742022;6727.663616819237;6811.284815094542;6838.760643377657;6732.192136943598;6780.796576102724;6781;6783.559068660521;6785.371510837264;6012.729427175875;6019.638821670714;6027.57806953509;6107.053406721965;6307.369263073656;6405.935940640534;6407.551471397144;6460.806175814733;6468.256150542559;6560.475161986934 05:31:07 INFO - PROCESS | 24956 | |4;prototype.html;324.05376301200494;333.80472423632176;335.4331180305285;347.7548328428458;352.62093249756504;5625.6905870177125;5785.161151633016;5798.82603521895;5888.735006924688;5891.145783861338;5563.969151259791;5742.397048309919;5745;5758.568107391941;5759.395263497336;4483.910321793563;4492.910141797162;4495.370648109268;4496.213162696531;4504.797284122206;4322.351647252905;4393.209222339993;4421.579949904753;4486.125205584913;4493.370928070073;4442.3336499525;4463.6429085673235;4470.552944705536;4473.396091527651;4476.418065651461;4472.217361961643;4475;4476.283794592866;4484.058347746977;4484.9327260090795;3957.0503079261057;3957.6438120569;3959.1487830116375;3963.850483359822;3966.5438474575503;5385.272988146589;5533.00405926933;5539.307586551681;5542.63972841764;5576.247206627094;5159.690418574897;5165;5169.147090730063;5172.353455818023;5175.689458632494;5814.622049566807;6140.0789881517685;6161.661108639023;6164.167837341991;6166.445019948226;4091.2022155679656;4157.48031496063;4192.664586833046;4195.91608167835;4198.874033778991;6275.121482992385;6356.332585078592;6369.777057802955;6370.458511026522;6371.044343348489;4384.934225986613;4385.188740083095;4392.231359512072;4392.978035109868;4395.846145384896;4268.829246830154;4396.538363471854;4442.4669039715445;4444.422225110715;4447.399601053881;5080.720560369141;5085.618578606619;5088.0587091388215;5088.363954505687;5098.362704661918;6135.877282454326;6172.290186628506;6176;6182.474489668429;6182.752689892354;1539.499662609634;1540.0528674864877;1541.8689411399932;1542.067049435098;1544.0426935300186;1017.6489111256604;1017.9389236645677;1040.38617215843;1047.1361127070197;1059.8622179116664;5806.709664516758;5813.82558523245;5815.73829177688;5827.213326200994;5835.44563266489;6304.085907543381;6307.274663413675;6309.148264984168;6310.6213627182515;6318.273398559225;5813.970930145407;5816.941830581724;5818.272715910512;5819.243498345273;5820.214271073351;3289.6052473703307;3383.018924511913;3399.218179818606;3403.387390269775;3406.880759173417;6497.480201583862;6511.544191906616;6527.314631963671;6532.934670653232;6540.476761859135;6501.707423165969;6505.121808555785;6505.544611877123;6509.8698026040165;6511.934880651228;6347.270063942613;6495.805125846232;6512.609243445314;6513.381228783258;6526.575772574767;6082.5438092142385;6218.751249949952;6290.874182516415;6298.559100862895;6310;6127.632342059491;6255.812325630239;6278.560500764903;6282.811515654537;6288.025356069817;6539.313372096051;6548.740684463853;6558.901616475852;6627.105340778933;6639.966800165968;4303.677224208134;4358.433403657505;4387.319965405367;4389.670774691975;4392.099619578043;6315.810525684236;6343.5876668016435;6344.968275158594;6347.746090156526;6352.333005034405;6167.537434692326;6174.691265436621;6180.289266734383;6194.4115309045565;6197.504199664107;6014.57897947157;6147.877042459215;6156.476699480594;6168.352323006199;6168.444839964424;6034.24571928509;6045.1234570987845;6046.54650901193;6062.90905636407;6069.150318955261;6191.25704915413;6191.5665903388135;6192.969035154795;6198.2252218472695;6198.566100372931;5940.46535811779;6041.909371359346;6049.909251361321;6056.121862329849;6060.060690592965 05:31:07 INFO - PROCESS | 24956 | |5;yui.html;715.4884257755705;774.0749803984241;792.3344390711801;805.4040010392304;853.7182729699202;13446.260455674934;13728.725425491484;13752.793708094387;13753.999999999987;13761.518346857862;12479.438425270862;12887.67780805478;12888.935555322234;12916.031297652667;12951.158174718637;627.4603840696997;658.8451713847242;769.872970959791;771.3559178086291;800.2397722163938;779.6413649721135;790.731151408521;792.4254915186501;794.5550491724624;796.8167321516025;835.1314632781899;837.8240569480416;838.2162677896156;838.4466252273501;838.8322335532918;655.5869802024718;684.4353408438034;813.780279324582;828.6933834481281;831.6423937706784;603.5262319079502;608.3642593489814;608.6804427675506;608.7291155435832;608.7352001879196;13379.063465557414;13433.261170635611;13443.798343024862;13454.461821527128;13468.057235993485;12591.559295424708;13117.540886068942;13304.201747895157;13394.732105357838;13423.66440838977;10483.161347092215;10527.684169474927;10583.259171857973;10599.788004239948;10625.096866766335;3362.697357237836;3429.4341433663417;3461.9826900865587;3540.238848647553;3540.2565461253166;44828.3275750864;44973.32540011902;44983.77508112471;45473.31790023152;46475.999999999665;9471.122371978438;9481.336306458481;9508.334416590911;9564.378315409476;9619.759506012406;18390.632187356445;18457.90771046136;18463.53841153982;18488.983105929303;18497.445076647724;7447.776566703008;7575.128860181039;7584.317411432887;7625.885611715828;7700.306972372401;4304.354346847936;4371.344298355272;4383.298672212431;4397.31841564558;4416.712913660602;3079.076277116856;3099.7520198384077;3100.2714362124884;3108;3111.9066428007195;559.4712996218616;567.324883388766;573.0086949577171;581.2298704216929;588.5762251179144;539.3204562251591;595.7259660556106;630.6531407725732;666.4834753066413;666.986660266792;7999.920000799918;8157.75526734199;8210.384221183434;8873.423227490193;9140.360174787702;498.3645851539244;578.9102689083198;606.2270604978687;619.9297017515246;630.5680608782999;3772.660460558563;3789.1474418256225;3847.0759824978923;4062.431259623596;4144.7513149211145;46237.76881115573;47346;47549.28676069862;47611.285830712564;48079;47371.289430658566;47587;47616;48246.75876620664;48408.27387589189;42240.366394504104;43366.7831660846;43886.56113438889;44003.77998109989;44112.117757644024;7870.763877083697;8034.15641357649;8262.628181731956;8321.625526851427;8495.108013658724;32972.1756956078;33407.665923341425;33546.496802547495;33613;33801.323973520884;39129.6087039126;40030;41521.79239103785;41979.37030944477;44303.55696442995;10021.448820314952;10215.795684086424;10415.270931034755;10553.525091370753;10690.89309106899;11202.192599975084;11439;11574.247673901169;11648.941755291507;12002.519899203933;10740.30188037775;11072.391018493738;11144.275622084539;11297.152713546353;11628.825567616323;10726.892731072901;11068.28056176346;11259.380734059705;11279.09767218604;11589.6523104307;10516.57933682644;10942.124630029737;10981.835272471078;11065.170112241452;11363.715907102389;8348.87476687838;8537.53043582609;8628.137186281321;8677.566121693764;8890.955545222232;8155.83688326242;8667.306615470621;8878.422902511316;8979.595918183566;9076.41003334781 05:31:07 INFO - PROCESS | 24956 | __end_tp_report 05:31:07 INFO - PROCESS | 24956 | __start_cc_report 05:31:07 INFO - PROCESS | 24956 | _x_x_mozilla_cycle_collect,909 05:31:07 INFO - PROCESS | 24956 | __end_cc_report 05:31:07 INFO - PROCESS | 24956 | __startTimestamp1452778267984__endTimestamp 05:31:07 INFO - PROCESS | 24956 | 05:31:07 INFO - PROCESS | 24956 | ------- Summary: start ------- 05:31:07 INFO - PROCESS | 24956 | Number of tests: 6 05:31:07 INFO - PROCESS | 24956 | 05:31:07 INFO - PROCESS | 24956 | [#0] dojo.html Cycles:165 Average:5168.35 Median:5351.12 stddev:553.81 (10.3%) stddev-sans-first:532.89 05:31:07 INFO - PROCESS | 24956 | Values: 3171.3 3179.9 3219.7 3233.2 3255.0 5009.2 5104.9 5126.2 5151.2 5186.4 5095.2 5152.4 5182.1 5186.6 5219.9 4671.6 4709.3 4726.1 4777.4 4787.2 4782.0 4788.6 4824.2 4845.5 4855.4 4630.0 4706.3 4707.3 4769.3 4802.6 4732.5 4744.4 4753.8 4765.9 4803.2 4585.0 4717.6 4730.8 4737.4 4788.8 5010.9 5025.4 5084.0 5099.1 5124.7 5528.3 5531.4 5531.6 5534.0 5539.5 5406.2 5521.1 5574.7 5581.6 5589.1 5245.8 5282.0 5300.8 5305.0 5352.1 5691.3 5698.0 5702.0 5719.9 5742.5 5267.9 5368.6 5460.9 5474.8 5488.3 5608.3 5608.9 5611.2 5614.2 5624.2 5552.8 5579.5 5579.7 5580.9 5582.7 5397.9 5495.4 5513.3 5553.5 5597.8 4301.8 4308.7 4310.1 4318.2 4354.3 3853.3 3864.2 3878.3 3906.8 3914.9 5081.8 5153.5 5172.0 5262.4 5272.6 5619.7 5629.5 5645.4 5650.5 5653.0 5217.4 5237.5 5240.1 5241.5 5285.4 4662.2 4723.6 4734.2 4764.0 4794.2 5771.0 5787.4 5788.6 5799.6 5799.7 5403.2 5604.8 5623.0 5625.9 5669.9 5592.5 5696.5 5772.9 5779.6 5794.5 5429.6 5430.7 5433.3 5440.8 5448.5 5480.4 5491.2 5499.8 5503.3 5531.3 5239.2 5267.6 5423.8 5533.4 5552.3 5468.2 5468.8 5470.8 5480.2 5481.4 5368.8 5381.4 5383.5 5387.8 5425.8 5310.5 5405.6 5442.5 5500.8 5543.4 5266.4 5284.9 5295.3 5298.5 5351.1 05:31:07 INFO - PROCESS | 24956 | 05:31:07 INFO - PROCESS | 24956 | [#1] ext.html Cycles:180 Average:50875.43 Median:21285.17 stddev:92005.32 (432.3%) stddev-sans-first:92185.75 05:31:07 INFO - PROCESS | 24956 | Values: 524.2 536.9 558.3 561.6 575.6 28095.7 28584.1 28592.4 35220.3 35971.8 42326.0 43284.8 43369.1 43463.9 43598.0 8524.6 8748.3 8753.3 8757.7 8762.9 8489.5 8599.2 8640.1 8641.0 8644.0 8326.9 8393.1 8400.6 8407.4 8408.3 8560.4 8664.2 8666.4 8669.5 8674.1 8412.7 8531.7 8535.4 8554.0 8558.1 38774.8 39099.0 39148.8 39177.0 39221.0 3263.9 3362.0 3399.3 3419.8 3905.5 28043.2 28750.4 28756.3 28762.6 28841.3 3717.8 3831.1 3848.8 3855.5 3938.6 280924.0 282061.0 282489.0 282866.0 283531.0 60966.7 61151.7 61270.4 61360.4 61380.0 65865.0 66043.7 66133.0 66170.7 66184.0 16229.1 16394.4 16403.8 16408.5 16424.8 12420.6 12470.4 12488.4 12506.2 12513.6 19500.8 20145.3 20319.5 20444.4 20464.0 6664.6 7896.0 8272.9 8411.3 8433.7 935.8 953.3 988.6 997.4 1073.8 28663.9 28787.1 29313.7 29361.9 29494.9 993.6 1074.8 1075.5 1103.8 1137.9 14887.4 14983.5 15021.6 15086.7 15091.2 302120.0 310726.0 353747.0 364805.0 365229.0 47268.3 47350.5 47465.1 47485.8 47566.3 1239.7 1273.7 1293.2 1303.9 1335.7 25916.7 27916.6 30024.2 30820.4 31309.5 43753.6 50758.5 51300.2 51355.4 51360.2 269349.0 435070.0 441333.0 443199.0 443599.0 39937.6 41370.0 41472.4 41538.0 41639.4 44566.0 44762.8 44808.8 45389.8 46161.0 37123.3 37466.3 37693.0 38145.2 38956.8 37657.4 37911.6 38471.8 38714.8 38864.0 32413.0 32935.7 33172.2 33228.5 33363.5 30014.2 32101.8 32540.7 32588.8 32621.5 24423.0 24566.6 24764.0 24944.8 25037.4 05:31:07 INFO - PROCESS | 24956 | 05:31:07 INFO - PROCESS | 24956 | [#2] jquery.html Cycles:180 Average:25246.58 Median:5050.39 stddev:80410.12 (1592.2%) stddev-sans-first:80613.98 05:31:07 INFO - PROCESS | 24956 | Values: 364.4 366.1 370.4 370.8 376.6 14161.2 14269.5 15434.9 16383.8 17230.2 15690.7 16229.3 16637.2 16950.4 16956.8 4833.3 4983.6 4986.6 4987.8 4992.7 3757.7 3887.8 4894.1 5242.4 5414.9 5241.6 5401.4 5402.3 5420.6 5445.1 5497.0 5522.5 5533.0 5545.2 5551.2 4934.9 5108.1 5109.9 5328.9 5329.2 12950.5 13199.9 17678.9 20269.5 20287.1 2044.5 2095.1 2191.4 2267.5 2279.9 9430.7 9468.1 9563.0 9630.3 11545.8 1765.2 1825.0 1828.3 1888.0 1918.3 56024.0 57581.7 58442.4 59034.0 59088.9 9788.6 9982.9 10116.1 10162.6 10226.8 13429.2 13506.3 13549.3 13568.3 13583.2 7674.2 7721.0 7742.5 7802.9 7806.1 7339.8 7379.3 7399.4 7429.7 7432.9 4049.0 4434.1 4469.2 4479.4 4486.2 1748.6 1751.5 1782.6 1809.4 1824.9 807.7 933.3 947.6 951.2 975.0 13874.9 14630.9 15213.8 15419.5 15440.7 908.6 920.0 921.5 925.8 926.2 9110.9 9146.7 9329.9 9525.5 9897.5 361600.0 362530.0 554506.0 564298.0 568075.0 61367.7 63129.0 63967.4 64041.4 64477.4 1091.3 1103.2 1135.0 1142.6 1144.1 11804.3 13654.0 13969.5 14191.7 14549.5 30341.2 30574.7 31378.2 31426.4 31901.8 35266.6 36011.5 36038.1 37163.3 39657.6 6923.4 7110.6 7199.4 7209.6 7435.0 10233.4 10739.8 11033.2 11051.7 11358.1 9464.8 9469.5 9532.0 9582.3 9615.6 8965.2 9261.1 9528.5 9563.3 9812.1 9060.5 9131.6 9436.7 9975.2 10210.1 7003.5 7215.1 7224.8 7227.5 7292.3 8079.0 8807.1 9067.0 9078.1 9226.2 05:31:07 INFO - PROCESS | 24956 | 05:31:07 INFO - PROCESS | 24956 | [#3] mootools.html Cycles:180 Average:5381.35 Median:6406.74 stddev:2712.68 (42.3%) stddev-sans-first:2702.92 05:31:07 INFO - PROCESS | 24956 | Values: 1297.8 1437.8 1443.4 1568.5 1744.2 6651.1 7532.1 7693.7 7709.5 7715.1 7317.6 7438.5 7457.7 7483.4 7504.2 1952.9 1987.2 2281.5 2316.6 2346.8 2365.0 2373.6 2374.2 2374.3 2377.9 2232.9 2279.1 2279.7 2281.7 2283.5 2244.7 2263.9 2326.5 2328.0 2328.5 2309.7 2343.1 2352.6 2359.4 2366.6 7709.4 7711.3 7752.0 7752.7 7780.8 4655.4 4732.4 4754.6 4770.0 4774.9 3054.2 3089.5 3139.8 3200.7 3203.6 1075.1 1842.2 1895.6 1899.1 1936.5 9784.0 9823.3 9833.0 9858.0 9868.2 3985.3 4010.8 4047.8 4050.7 4167.4 8082.6 8089.9 8091.4 8095.2 8095.4 4667.7 4677.3 4687.8 4690.6 4700.2 4288.3 4320.3 4328.7 4330.0 4337.4 3203.2 3254.9 3257.9 3553.2 3614.1 1121.6 1138.1 1144.2 1148.0 1152.0 1293.8 1299.1 1301.5 1302.6 1327.5 7179.4 7255.8 7292.1 7295.1 7300.6 1078.4 1079.2 1083.1 1089.6 1096.8 5826.9 5902.9 5907.4 5911.3 5916.6 9348.2 9441.5 9530.2 9731.7 9751.2 9535.9 9569.8 9608.4 9612.1 9621.4 7243.3 7397.0 7406.3 7458.1 7460.3 6981.1 7008.0 7012.4 7031.3 7037.0 8358.9 8525.6 8557.8 8649.7 8822.2 8738.6 8755.4 8802.2 8951.9 8957.1 6531.4 6629.7 6661.3 6662.2 6665.8 6429.1 6576.6 7054.4 7278.9 7320.9 6743.5 6773.8 6884.0 6918.9 6994.5 6585.2 6718.2 6727.7 6811.3 6838.8 6732.2 6780.8 6781.0 6783.6 6785.4 6012.7 6019.6 6027.6 6107.1 6307.4 6405.9 6407.6 6460.8 6468.3 6560.5 05:31:07 INFO - PROCESS | 24956 | 05:31:07 INFO - PROCESS | 24956 | [#4] prototype.html Cycles:180 Average:5132.96 Median:5814.30 stddev:1539.49 (26.5%) stddev-sans-first:1500.90 05:31:08 INFO - PROCESS | 24956 | Values: 324.1 333.8 335.4 347.8 352.6 5625.7 5785.2 5798.8 5888.7 5891.1 5564.0 5742.4 5745.0 5758.6 5759.4 4483.9 4492.9 4495.4 4496.2 4504.8 4322.4 4393.2 4421.6 4486.1 4493.4 4442.3 4463.6 4470.6 4473.4 4476.4 4472.2 4475.0 4476.3 4484.1 4484.9 3957.1 3957.6 3959.1 3963.9 3966.5 5385.3 5533.0 5539.3 5542.6 5576.2 5159.7 5165.0 5169.1 5172.4 5175.7 5814.6 6140.1 6161.7 6164.2 6166.4 4091.2 4157.5 4192.7 4195.9 4198.9 6275.1 6356.3 6369.8 6370.5 6371.0 4384.9 4385.2 4392.2 4393.0 4395.8 4268.8 4396.5 4442.5 4444.4 4447.4 5080.7 5085.6 5088.1 5088.4 5098.4 6135.9 6172.3 6176.0 6182.5 6182.8 1539.5 1540.1 1541.9 1542.1 1544.0 1017.6 1017.9 1040.4 1047.1 1059.9 5806.7 5813.8 5815.7 5827.2 5835.4 6304.1 6307.3 6309.1 6310.6 6318.3 5814.0 5816.9 5818.3 5819.2 5820.2 3289.6 3383.0 3399.2 3403.4 3406.9 6497.5 6511.5 6527.3 6532.9 6540.5 6501.7 6505.1 6505.5 6509.9 6511.9 6347.3 6495.8 6512.6 6513.4 6526.6 6082.5 6218.8 6290.9 6298.6 6310.0 6127.6 6255.8 6278.6 6282.8 6288.0 6539.3 6548.7 6558.9 6627.1 6640.0 4303.7 4358.4 4387.3 4389.7 4392.1 6315.8 6343.6 6345.0 6347.7 6352.3 6167.5 6174.7 6180.3 6194.4 6197.5 6014.6 6147.9 6156.5 6168.4 6168.4 6034.2 6045.1 6046.5 6062.9 6069.2 6191.3 6191.6 6193.0 6198.2 6198.6 5940.5 6041.9 6049.9 6056.1 6060.1 05:31:08 INFO - PROCESS | 24956 | 05:31:08 INFO - PROCESS | 24956 | [#5] yui.html Cycles:180 Average:13018.94 Median:44900.83 stddev:14463.90 (32.2%) stddev-sans-first:14474.96 05:31:08 INFO - PROCESS | 24956 | Values: 715.5 774.1 792.3 805.4 853.7 13446.3 13728.7 13752.8 13754.0 13761.5 12479.4 12887.7 12888.9 12916.0 12951.2 627.5 658.8 769.9 771.4 800.2 779.6 790.7 792.4 794.6 796.8 835.1 837.8 838.2 838.4 838.8 655.6 684.4 813.8 828.7 831.6 603.5 608.4 608.7 608.7 608.7 13379.1 13433.3 13443.8 13454.5 13468.1 12591.6 13117.5 13304.2 13394.7 13423.7 10483.2 10527.7 10583.3 10599.8 10625.1 3362.7 3429.4 3462.0 3540.2 3540.3 44828.3 44973.3 44983.8 45473.3 46476.0 9471.1 9481.3 9508.3 9564.4 9619.8 18390.6 18457.9 18463.5 18489.0 18497.4 7447.8 7575.1 7584.3 7625.9 7700.3 4304.4 4371.3 4383.3 4397.3 4416.7 3079.1 3099.8 3100.3 3108.0 3111.9 559.5 567.3 573.0 581.2 588.6 539.3 595.7 630.7 666.5 667.0 7999.9 8157.8 8210.4 8873.4 9140.4 498.4 578.9 606.2 619.9 630.6 3772.7 3789.1 3847.1 4062.4 4144.8 46237.8 47346.0 47549.3 47611.3 48079.0 47371.3 47587.0 47616.0 48246.8 48408.3 42240.4 43366.8 43886.6 44003.8 44112.1 7870.8 8034.2 8262.6 8321.6 8495.1 32972.2 33407.7 33546.5 33613.0 33801.3 39129.6 40030.0 41521.8 41979.4 44303.6 10021.4 10215.8 10415.3 10553.5 10690.9 11202.2 11439.0 11574.2 11648.9 12002.5 10740.3 11072.4 11144.3 11297.2 11628.8 10726.9 11068.3 11259.4 11279.1 11589.7 10516.6 10942.1 10981.8 11065.2 11363.7 8348.9 8537.5 8628.1 8677.6 8891.0 8155.8 8667.3 8878.4 8979.6 9076.4 05:31:08 INFO - PROCESS | 24956 | -------- Summary: end -------- 05:31:08 INFO - PROCESS | 24956 | 05:31:08 INFO - TEST-INFO | 24956: exit 0 05:31:08 INFO - TEST-OK | dromaeo_css | took 1112446ms 05:31:08 INFO - TEST-START | kraken 05:31:08 INFO - operating with platform_type : linux_ 05:31:08 INFO - Initialising browser for kraken test... 05:31:08 INFO - TEST-INFO | started process 25149 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeaHUHC/profile http://localhost:59393/getInfo.html) 05:31:12 INFO - PROCESS | 25149 | __metrics Screen width/height:1600/1200 05:31:12 INFO - PROCESS | 25149 | colorDepth:24 05:31:12 INFO - PROCESS | 25149 | Browser inner width/height: 1024/697 05:31:12 INFO - PROCESS | 25149 | __metrics 05:31:12 INFO - PROCESS | 25149 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:31:12 INFO - PROCESS | 25149 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:31:13 INFO - TEST-INFO | 25149: exit 0 05:31:13 INFO - Browser initialized. 05:31:13 INFO - Running cycle 1/1 for kraken test... 05:31:13 INFO - TEST-INFO | started process 25233 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpeaHUHC/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:25 INFO - PROCESS | 25233 | RSS: Main: 150515712 05:31:25 INFO - PROCESS | 25233 | 05:31:27 INFO - PROCESS | 25233 | Cycle 1(1): loaded http://localhost:59393/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59393/tests/kraken/driver.html?testName=audio-beat-detection) 05:31:28 INFO - PROCESS | 25233 | RSS: Main: 185896960 05:31:28 INFO - PROCESS | 25233 | 05:31:31 INFO - PROCESS | 25233 | Cycle 1(1): loaded http://localhost:59393/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59393/tests/kraken/driver.html?testName=audio-dft) 05:31:31 INFO - PROCESS | 25233 | RSS: Main: 176394240 05:31:31 INFO - PROCESS | 25233 | 05:31:34 INFO - PROCESS | 25233 | Cycle 1(1): loaded http://localhost:59393/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59393/tests/kraken/driver.html?testName=audio-fft) 05:31:35 INFO - PROCESS | 25233 | RSS: Main: 160763904 05:31:35 INFO - PROCESS | 25233 | 05:31:37 INFO - PROCESS | 25233 | Cycle 1(1): loaded http://localhost:59393/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59393/tests/kraken/driver.html?testName=audio-oscillator) 05:31:37 INFO - PROCESS | 25233 | RSS: Main: 162553856 05:31:37 INFO - PROCESS | 25233 | 05:31:39 INFO - PROCESS | 25233 | Cycle 1(1): loaded http://localhost:59393/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59393/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:31:40 INFO - PROCESS | 25233 | RSS: Main: 166514688 05:31:40 INFO - PROCESS | 25233 | 05:31:43 INFO - PROCESS | 25233 | Cycle 1(1): loaded http://localhost:59393/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59393/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:44 INFO - PROCESS | 25233 | RSS: Main: 166047744 05:31:44 INFO - PROCESS | 25233 | 05:31:47 INFO - PROCESS | 25233 | Cycle 1(1): loaded http://localhost:59393/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59393/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:47 INFO - PROCESS | 25233 | RSS: Main: 166354944 05:31:47 INFO - PROCESS | 25233 | 05:31:50 INFO - PROCESS | 25233 | Cycle 1(1): loaded http://localhost:59393/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59393/tests/kraken/driver.html?testName=json-parse-financial) 05:31:51 INFO - PROCESS | 25233 | RSS: Main: 165711872 05:31:51 INFO - PROCESS | 25233 | 05:31:52 INFO - PROCESS | 25233 | Cycle 1(1): loaded http://localhost:59393/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59393/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:53 INFO - PROCESS | 25233 | RSS: Main: 176668672 05:31:53 INFO - PROCESS | 25233 | 05:31:55 INFO - PROCESS | 25233 | Cycle 1(1): loaded http://localhost:59393/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59393/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:55 INFO - PROCESS | 25233 | RSS: Main: 174796800 05:31:55 INFO - PROCESS | 25233 | 05:31:57 INFO - PROCESS | 25233 | Cycle 1(1): loaded http://localhost:59393/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59393/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:58 INFO - PROCESS | 25233 | RSS: Main: 187052032 05:31:58 INFO - PROCESS | 25233 | 05:32:00 INFO - PROCESS | 25233 | Cycle 1(1): loaded http://localhost:59393/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:32:01 INFO - PROCESS | 25233 | RSS: Main: 193753088 05:32:01 INFO - PROCESS | 25233 | 05:32:03 INFO - PROCESS | 25233 | Cycle 1(1): loaded http://localhost:59393/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:32:04 INFO - PROCESS | 25233 | RSS: Main: 191496192 05:32:04 INFO - PROCESS | 25233 | 05:32:06 INFO - PROCESS | 25233 | Cycle 1(1): loaded http://localhost:59393/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59393/tests/kraken/driver.html?testName=ai-astar) 05:32:06 INFO - PROCESS | 25233 | RSS: Main: 249118720 05:32:06 INFO - PROCESS | 25233 | 05:32:06 INFO - PROCESS | 25233 | __start_tp_report 05:32:06 INFO - PROCESS | 25233 | _x_x_mozilla_page_load 05:32:06 INFO - PROCESS | 25233 | _x_x_mozilla_page_load_details 05:32:06 INFO - PROCESS | 25233 | |i|pagename|runs| 05:32:06 INFO - PROCESS | 25233 | |0;ai-astar;110;111;105;108;110;110;99;110;109;108 05:32:06 INFO - PROCESS | 25233 | |1;audio-beat-detection;150;132;158;167;123;155;162;132;175;127 05:32:06 INFO - PROCESS | 25233 | |2;audio-dft;162;161;160;161;160;161;159;163;159;160 05:32:06 INFO - PROCESS | 25233 | |3;audio-fft;74;71;120;94;70;71;72;110;94;72 05:32:06 INFO - PROCESS | 25233 | |4;audio-oscillator;95;95;141;96;97;97;140;95;96;147 05:32:06 INFO - PROCESS | 25233 | |5;imaging-gaussian-blur;109;109;109;108;109;110;109;109;109;109 05:32:06 INFO - PROCESS | 25233 | |6;imaging-darkroom;145;145;145;145;145;145;145;146;146;145 05:32:06 INFO - PROCESS | 25233 | |7;imaging-desaturate;95;96;95;95;97;96;96;95;96;95 05:32:06 INFO - PROCESS | 25233 | |8;json-parse-financial;58;54;54;54;54;54;56;65;53;52 05:32:06 INFO - PROCESS | 25233 | |9;json-stringify-tinderbox;66;67;67;66;66;67;67;66;68;67 05:32:06 INFO - PROCESS | 25233 | |10;stanford-crypto-aes;80;79;88;82;82;81;85;81;83;90 05:32:06 INFO - PROCESS | 25233 | |11;stanford-crypto-ccm;112;118;122;123;120;116;126;113;120;114 05:32:06 INFO - PROCESS | 25233 | |12;stanford-crypto-pbkdf2;144;137;144;151;144;133;146;139;141;141 05:32:06 INFO - PROCESS | 25233 | |13;stanford-crypto-sha256-iterative;68;65;67;64;67;70;67;74;65;64 05:32:06 INFO - PROCESS | 25233 | __end_tp_report 05:32:06 INFO - PROCESS | 25233 | __start_cc_report 05:32:06 INFO - PROCESS | 25233 | _x_x_mozilla_cycle_collect,935 05:32:06 INFO - PROCESS | 25233 | __end_cc_report 05:32:06 INFO - PROCESS | 25233 | __startTimestamp1452778326319__endTimestamp 05:32:06 INFO - PROCESS | 25233 | 05:32:06 INFO - PROCESS | 25233 | ------- Summary: start ------- 05:32:06 INFO - PROCESS | 25233 | Number of tests: 14 05:32:06 INFO - PROCESS | 25233 | 05:32:06 INFO - PROCESS | 25233 | [#0] ai-astar Cycles:10 Average:108.00 Median:110.00 stddev:3.59 (3.3%) stddev-sans-first:3.73 05:32:06 INFO - PROCESS | 25233 | Values: 110.0 111.0 105.0 108.0 110.0 110.0 99.0 110.0 109.0 108.0 05:32:06 INFO - PROCESS | 25233 | 05:32:06 INFO - PROCESS | 25233 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:156.50 stddev:18.31 (11.7%) stddev-sans-first:19.41 05:32:06 INFO - PROCESS | 25233 | Values: 150.0 132.0 158.0 167.0 123.0 155.0 162.0 132.0 175.0 127.0 05:32:06 INFO - PROCESS | 25233 | 05:32:06 INFO - PROCESS | 25233 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.26 (0.8%) stddev-sans-first:1.24 05:32:06 INFO - PROCESS | 25233 | Values: 162.0 161.0 160.0 161.0 160.0 161.0 159.0 163.0 159.0 160.0 05:32:06 INFO - PROCESS | 25233 | 05:32:06 INFO - PROCESS | 25233 | [#3] audio-fft Cycles:10 Average:84.80 Median:72.00 stddev:18.52 (25.7%) stddev-sans-first:19.23 05:32:06 INFO - PROCESS | 25233 | Values: 74.0 71.0 120.0 94.0 70.0 71.0 72.0 110.0 94.0 72.0 05:32:06 INFO - PROCESS | 25233 | 05:32:06 INFO - PROCESS | 25233 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:95.50 stddev:22.69 (23.8%) stddev-sans-first:23.42 05:32:06 INFO - PROCESS | 25233 | Values: 95.0 95.0 141.0 96.0 97.0 97.0 140.0 95.0 96.0 147.0 05:32:06 INFO - PROCESS | 25233 | 05:32:06 INFO - PROCESS | 25233 | [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 05:32:06 INFO - PROCESS | 25233 | Values: 109.0 109.0 109.0 108.0 109.0 110.0 109.0 109.0 109.0 109.0 05:32:06 INFO - PROCESS | 25233 | 05:32:06 INFO - PROCESS | 25233 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 05:32:06 INFO - PROCESS | 25233 | Values: 145.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 146.0 145.0 05:32:06 INFO - PROCESS | 25233 | 05:32:06 INFO - PROCESS | 25233 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 05:32:06 INFO - PROCESS | 25233 | Values: 95.0 96.0 95.0 95.0 97.0 96.0 96.0 95.0 96.0 95.0 05:32:06 INFO - PROCESS | 25233 | 05:32:06 INFO - PROCESS | 25233 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.00 stddev:3.75 (6.9%) stddev-sans-first:3.86 05:32:06 INFO - PROCESS | 25233 | Values: 58.0 54.0 54.0 54.0 54.0 54.0 56.0 65.0 53.0 52.0 05:32:06 INFO - PROCESS | 25233 | 05:32:06 INFO - PROCESS | 25233 | [#9] json-stringify-tinderbox Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 05:32:06 INFO - PROCESS | 25233 | Values: 66.0 67.0 67.0 66.0 66.0 67.0 67.0 66.0 68.0 67.0 05:32:06 INFO - PROCESS | 25233 | 05:32:06 INFO - PROCESS | 25233 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:82.50 stddev:3.54 (4.3%) stddev-sans-first:3.57 05:32:06 INFO - PROCESS | 25233 | Values: 80.0 79.0 88.0 82.0 82.0 81.0 85.0 81.0 83.0 90.0 05:32:06 INFO - PROCESS | 25233 | 05:32:06 INFO - PROCESS | 25233 | [#11] stanford-crypto-ccm Cycles:10 Average:118.40 Median:120.00 stddev:4.62 (3.9%) stddev-sans-first:4.28 05:32:06 INFO - PROCESS | 25233 | Values: 112.0 118.0 122.0 123.0 120.0 116.0 126.0 113.0 120.0 114.0 05:32:06 INFO - PROCESS | 25233 | 05:32:06 INFO - PROCESS | 25233 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.00 Median:144.00 stddev:5.01 (3.5%) stddev-sans-first:5.26 05:32:06 INFO - PROCESS | 25233 | Values: 144.0 137.0 144.0 151.0 144.0 133.0 146.0 139.0 141.0 141.0 05:32:06 INFO - PROCESS | 25233 | 05:32:06 INFO - PROCESS | 25233 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:3.07 (4.6%) stddev-sans-first:3.24 05:32:06 INFO - PROCESS | 25233 | Values: 68.0 65.0 67.0 64.0 67.0 70.0 67.0 74.0 65.0 64.0 05:32:06 INFO - PROCESS | 25233 | -------- Summary: end -------- 05:32:06 INFO - PROCESS | 25233 | 05:32:07 INFO - TEST-INFO | 25233: exit 0 05:32:07 INFO - TEST-OK | kraken | took 58509ms 05:32:07 INFO - TEST-START | v8_7 05:32:07 INFO - operating with platform_type : linux_ 05:32:07 INFO - Initialising browser for v8_7 test... 05:32:07 INFO - TEST-INFO | started process 25483 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxNKKz3/profile http://localhost:59393/getInfo.html) 05:32:11 INFO - PROCESS | 25483 | __metrics Screen width/height:1600/1200 05:32:11 INFO - PROCESS | 25483 | colorDepth:24 05:32:11 INFO - PROCESS | 25483 | Browser inner width/height: 1024/697 05:32:11 INFO - PROCESS | 25483 | __metrics 05:32:11 INFO - PROCESS | 25483 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:32:11 INFO - PROCESS | 25483 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:32:12 INFO - TEST-INFO | 25483: exit 0 05:32:12 INFO - Browser initialized. 05:32:12 INFO - Running cycle 1/1 for v8_7 test... 05:32:12 INFO - TEST-INFO | started process 25569 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxNKKz3/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:24 INFO - PROCESS | 25569 | RSS: Main: 151031808 05:32:24 INFO - PROCESS | 25569 | 05:32:46 INFO - PROCESS | 25569 | Cycle 1(1): loaded http://localhost:59393/tests/v8_7/run.html (next: http://localhost:59393/tests/v8_7/run.html) 05:32:46 INFO - PROCESS | 25569 | RSS: Main: 572665856 05:32:46 INFO - PROCESS | 25569 | 05:32:46 INFO - PROCESS | 25569 | __start_tp_report 05:32:46 INFO - PROCESS | 25569 | _x_x_mozilla_page_load 05:32:46 INFO - PROCESS | 25569 | _x_x_mozilla_page_load_details 05:32:46 INFO - PROCESS | 25569 | |i|pagename|runs| 05:32:46 INFO - PROCESS | 25569 | |0;Richards;166.88918558077435 05:32:46 INFO - PROCESS | 25569 | |1;DeltaBlue;194.55252918287937 05:32:46 INFO - PROCESS | 25569 | |2;Encrypt;282.88543140028287 05:32:46 INFO - PROCESS | 25569 | |3;Decrypt;5240.837696335078 05:32:46 INFO - PROCESS | 25569 | |4;RayTrace;1098.901098901099 05:32:46 INFO - PROCESS | 25569 | |5;Earley;792.3930269413629 05:32:46 INFO - PROCESS | 25569 | |6;Boyer;12382.716049382716 05:32:46 INFO - PROCESS | 25569 | |7;RegExp;42729.166666666664 05:32:46 INFO - PROCESS | 25569 | |8;Splay;599.1611743559017 05:32:46 INFO - PROCESS | 25569 | |9;NavierStokes;4822.115384615385 05:32:46 INFO - PROCESS | 25569 | __end_tp_report 05:32:46 INFO - PROCESS | 25569 | __startTimestamp1452778366647__endTimestamp 05:32:46 INFO - PROCESS | 25569 | 05:32:46 INFO - PROCESS | 25569 | ------- Summary: start ------- 05:32:46 INFO - PROCESS | 25569 | Number of tests: 10 05:32:46 INFO - PROCESS | 25569 | 05:32:46 INFO - PROCESS | 25569 | [#0] Richards Cycles:1 Average:166.89 Median:166.89 stddev:0.00 (0.0%) 05:32:46 INFO - PROCESS | 25569 | Values: 166.9 05:32:46 INFO - PROCESS | 25569 | 05:32:46 INFO - PROCESS | 25569 | [#1] DeltaBlue Cycles:1 Average:194.55 Median:194.55 stddev:0.00 (0.0%) 05:32:46 INFO - PROCESS | 25569 | Values: 194.6 05:32:46 INFO - PROCESS | 25569 | 05:32:46 INFO - PROCESS | 25569 | [#2] Encrypt Cycles:1 Average:282.89 Median:282.89 stddev:0.00 (0.0%) 05:32:46 INFO - PROCESS | 25569 | Values: 282.9 05:32:46 INFO - PROCESS | 25569 | 05:32:46 INFO - PROCESS | 25569 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 05:32:46 INFO - PROCESS | 25569 | Values: 5240.8 05:32:46 INFO - PROCESS | 25569 | 05:32:46 INFO - PROCESS | 25569 | [#4] RayTrace Cycles:1 Average:1098.90 Median:1098.90 stddev:0.00 (0.0%) 05:32:46 INFO - PROCESS | 25569 | Values: 1098.9 05:32:46 INFO - PROCESS | 25569 | 05:32:46 INFO - PROCESS | 25569 | [#5] Earley Cycles:1 Average:792.39 Median:792.39 stddev:0.00 (0.0%) 05:32:46 INFO - PROCESS | 25569 | Values: 792.4 05:32:46 INFO - PROCESS | 25569 | 05:32:46 INFO - PROCESS | 25569 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 05:32:46 INFO - PROCESS | 25569 | Values: 12382.7 05:32:46 INFO - PROCESS | 25569 | 05:32:46 INFO - PROCESS | 25569 | [#7] RegExp Cycles:1 Average:42729.17 Median:42729.17 stddev:0.00 (0.0%) 05:32:46 INFO - PROCESS | 25569 | Values: 42729.2 05:32:46 INFO - PROCESS | 25569 | 05:32:46 INFO - PROCESS | 25569 | [#8] Splay Cycles:1 Average:599.16 Median:599.16 stddev:0.00 (0.0%) 05:32:46 INFO - PROCESS | 25569 | Values: 599.2 05:32:46 INFO - PROCESS | 25569 | 05:32:46 INFO - PROCESS | 25569 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 05:32:46 INFO - PROCESS | 25569 | Values: 4822.1 05:32:46 INFO - PROCESS | 25569 | -------- Summary: end -------- 05:32:46 INFO - PROCESS | 25569 | 05:32:47 INFO - TEST-INFO | 25569: exit 0 05:32:47 INFO - TEST-OK | v8_7 | took 40316ms 05:32:47 INFO - SUITE-END | took 1211s 05:32:47 INFO - Completed test suite (00:20:11) 05:32:47 INFO - Working with test: dromaeo_css 05:32:47 INFO - Generating results file: dromaeo_css 05:32:47 INFO - Working with test: kraken 05:32:47 INFO - Generating results file: kraken 05:32:47 INFO - javascript benchmark 05:32:47 INFO - Working with test: v8_7 05:32:47 INFO - Generating results file: v8_7 05:32:47 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:32:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:32:47 INFO - process_Request line: dromaeo_css 6777.06 graph.html#tests=[[72,64,35]] 05:32:47 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:32:47 INFO - process_Request line: kraken 1493.90 graph.html#tests=[[232,64,35]] 05:32:47 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:32:47 INFO - process_Request line: v8_7 19928.64 graph.html#tests=[[230,64,35]] 05:32:47 INFO - RETURN: dromaeo_css: 6777.06 05:32:47 INFO - RETURN: kraken: 1493.90 05:32:47 INFO - RETURN: v8_7: 19928.64 05:32:47 INFO - javascript benchmark 05:32:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3171.3023134910313, 3179.8887038953635, 3219.726323262523, 3233.1593785615746, 3255.0234929521143, 5009.248612708096, 5104.872378190538, 5126.179811230204, 5151.184732657199, 5186.35170603675, 5095.159298715716, 5152.355955505562, 5182.11903976324, 5186.585073194145, 5219.921701174476, 4671.579557839794, 4709.340692303072, 4726.0547890421885, 4777.426708794949, 4787.1622466068475, 4781.952180478185, 4788.640851936101, 4824.2040063389495, 4845.491223421543, 4855.368802055727, 4630.0, 4706.270528068155, 4707.340972263886, 4769.332293478916, 4802.615790736768, 4732.526747325274, 4744.359511465942, 4753.786079626425, 4765.880852978668, 4803.159447096779, 4584.977075114636, 4717.622590192811, 4730.763461826929, 4737.384140061805, 4788.7605619719225, 5010.874728131789, 5025.447200807908, 5083.974580127113, 5099.133147364957, 5124.718140502271, 5528.253685752412, 5531.3915469298345, 5531.557475401958, 5534.0, 5539.501444869981, 5406.216098665711, 5521.089020311684, 5574.693391863487, 5581.581381396411, 5589.077802162638, 5245.816396426145, 5282.0, 5300.761465734051, 5304.999999999962, 5352.116900711378, 5691.345495268097, 5698.0, 5701.971490142523, 5719.857003574861, 5742.511886489695, 5267.947320526822, 5368.624196306299, 5460.890782184334, 5474.7810087596845, 5488.313960754906, 5608.298962629671, 5608.915866262009, 5611.158326251095, 5614.242077319591, 5624.21261023457, 5552.7778888843995, 5579.46995035471, 5579.721013949286, 5580.860478487989, 5582.665040097607, 5397.865053373697, 5495.368032676293, 5513.283273174462, 5553.4724201200825, 5597.80407685729, 4301.784910754513, 4308.655307575386, 4310.094880075157, 4318.201132790444, 4354.259775838115, 3853.3064048470983, 3864.169203621235, 3878.3019056569524, 3906.824192911326, 3914.9021274468364, 5081.7967281309075, 5153.484651534816, 5172.0, 5262.368515778131, 5272.604554658339, 5619.690916999604, 5629.521490673257, 5645.379008309083, 5650.463205995424, 5652.971735141298, 5217.426083130853, 5237.476252374732, 5240.135377662643, 5241.528262456321, 5285.392179899284, 4662.160811053975, 4723.551262630044, 4734.242521196592, 4764.0471905619015, 4794.232922732346, 5770.971145144247, 5787.363390027093, 5788.565857560699, 5799.623024503394, 5799.652020878761, 5403.216533602685, 5604.775808967595, 5623.044082506066, 5625.8593535161945, 5669.886602268014, 5592.496675299242, 5696.4588364107, 5772.855678608068, 5779.595428319977, 5794.536437084938, 5429.592780541396, 5430.67415955044, 5433.320834895638, 5440.809571664972, 5448.509634132947, 5480.369757477782, 5491.231227628055, 5499.807506737245, 5503.257060296809, 5531.308586426697, 5239.214117882196, 5267.604929630216, 5423.755930983037, 5533.363663178786, 5552.33371995347, 5468.152436372368, 5468.753906074316, 5470.781168753205, 5480.205370221375, 5481.424450432806, 5368.785248590013, 5381.381141168816, 5383.515483606494, 5387.757550910297, 5425.755840987086, 5310.495502927216, 5405.567554595702, 5442.510174084351, 5500.834974950758, 5543.417941116125, 5266.394364648115, 5284.947150528599, 5295.311609490742, 5298.470152984671, 5351.117065684274], "unit": "score", "name": "dojo.html", "value": 5134.21605711446}, {"lowerIsBetter": false, "replicates": [524.2005940940066, 536.8899375627997, 558.3272157050754, 561.5563704673309, 575.5999580291697, 28095.719042809567, 28584.142475725737, 28592.428151436983, 35220.2955940881, 35971.820140899326, 42326.0, 43284.783576082154, 43369.132617347714, 43463.91340216496, 43598.0, 8524.573771311425, 8748.294082653885, 8753.299736021103, 8757.737267881974, 8762.86855697165, 8489.490630562155, 8599.183077607617, 8640.135986401341, 8641.049484556694, 8643.956780216091, 8326.875096873551, 8393.118722534138, 8400.621972011275, 8407.411481196319, 8408.32733381328, 8560.357973152039, 8664.22022018015, 8666.35002374818, 8669.523176225304, 8674.08922063187, 8412.705555305534, 8531.658733650647, 8535.402521823475, 8554.0, 8558.058613552505, 38774.80612596947, 39099.0, 39148.80425597882, 39177.0, 39221.0, 3263.918402039968, 3362.041818081835, 3399.2521645238007, 3419.8461069251694, 3905.49228600283, 28043.158705238875, 28750.424991500262, 28756.281092972633, 28762.568561471595, 28841.278968025967, 3717.8326975286177, 3831.1188426661747, 3848.7883166425836, 3855.5373355197557, 3938.5864484229314, 280924.0, 282061.0, 282489.0, 282865.99999999796, 283531.0, 60966.69516652388, 61151.69424152851, 61270.38729612736, 61360.38639613636, 61380.0, 65865.0, 66043.66978165174, 66133.0, 66170.66914665396, 66184.0, 16229.107399092927, 16394.426195083113, 16403.753943690856, 16408.507744767678, 16424.75362869558, 12420.565280215329, 12470.438830252479, 12488.438020289108, 12506.249625022529, 12513.624591262276, 19500.8049919499, 20145.29491467821, 20319.4920126998, 20444.386668399973, 20464.0, 6664.566803157779, 7896.0, 8272.875906861402, 8411.3270938326, 8433.692777619479, 935.7520257131865, 953.270747877874, 988.560090759605, 997.4115271989562, 1073.758404359013, 28663.85668071688, 28787.136385908456, 29313.706862931525, 29361.85319073391, 29494.852525737235, 993.6174572789383, 1074.7581794096266, 1075.4622688655672, 1103.7626910214342, 1137.852079229695, 14887.404503819726, 14983.475578354706, 15021.624459388602, 15086.698266034837, 15091.24543772807, 302120.0, 310726.0, 353747.0, 364805.0, 365229.0, 47268.29097563539, 47350.5264947353, 47465.05069898652, 47485.81285467891, 47566.28650570244, 1239.6590937492263, 1273.7134144817342, 1293.1659079893416, 1303.9413226404833, 1335.746208220435, 25916.740832591433, 27916.581251281652, 30024.24939376533, 30820.383592328475, 31309.53035704421, 43753.56246437495, 50758.49241507686, 51300.23049654184, 51355.37801597874, 51360.22959655683, 269349.0, 435070.0, 441333.0, 443199.0, 443599.0, 39937.600623993385, 41370.0, 41472.37791433191, 41538.0, 41639.37540936828, 44566.0, 44762.77618611886, 44808.77595612001, 45389.773051134536, 46161.0, 37123.25753484969, 37466.2506749858, 37693.0, 38145.2370952585, 38956.80521597374, 37657.4351384724, 37911.62088379081, 38471.80764096162, 38714.80642596769, 38864.02839928911, 32413.0, 32935.67064329326, 33172.17069573183, 33228.50157247692, 33363.49954750632, 30014.24964375908, 32101.83949080333, 32540.674593254713, 32588.83705581457, 32621.510677340335, 24423.0, 24566.63150052715, 24764.0, 24944.75055249497, 25037.374065648506], "unit": "score", "name": "ext.html", "value": 18824.900608646472}, {"lowerIsBetter": false, "replicates": [364.35145441114815, 366.11400411005366, 370.42583994808047, 370.82756518219026, 376.6008031486623, 14161.150330980148, 14269.539063162476, 15434.922825385871, 16383.754243686339, 17230.224639891218, 15690.686186276267, 16229.26968286427, 16637.1681415929, 16950.406735764253, 16956.83043169568, 4833.299171620113, 4983.576396006344, 4986.551210391064, 4987.8254261100865, 4992.650514463989, 3757.6805971492317, 3887.7667339959553, 4894.143524883149, 5242.370915490146, 5414.8917021659545, 5241.554467870235, 5401.351837779472, 5402.297701298826, 5420.647657902224, 5445.101558242885, 5497.038018346793, 5522.530584900268, 5532.972335138339, 5545.1682247662975, 5551.2228288039705, 4934.925976110361, 5108.131617625013, 5109.897802043938, 5328.866778330534, 5329.2006199070065, 12950.48198072076, 13199.86800131996, 17678.911605441892, 20269.493262668402, 20287.087081081387, 2044.4786579422152, 2095.078165607143, 2191.430228140679, 2267.535155293161, 2279.908803647852, 9430.669926552606, 9468.100530449596, 9563.043695630382, 9630.3258771886, 11545.769084618261, 1765.1527266911826, 1825.0, 1828.2504173288887, 1887.9622407551772, 1918.2710569983456, 56024.0, 57581.712091439695, 58442.41557584455, 59034.0, 59088.90933088014, 9788.608455661693, 9982.850257246148, 10116.08955194036, 10162.644307449204, 10226.846597301046, 13429.194248345131, 13506.324683765772, 13549.25479098659, 13568.253746044062, 13583.185008899498, 7674.232576742281, 7720.961395192988, 7742.535447873146, 7802.907592936994, 7806.1413244543055, 7339.816504587321, 7379.298966598272, 7399.4450416219, 7429.702811887464, 7432.888506672404, 4049.0, 4434.135343607965, 4469.195544801967, 4479.440069991251, 4486.192485352668, 1748.5541186997489, 1751.474557632705, 1782.5721826761744, 1809.3757653609484, 1824.852130075609, 807.6850028488894, 933.332667142996, 947.5593848860314, 951.2009911674227, 974.9610015599438, 13874.93062534681, 14630.926845365919, 15213.847861521464, 15419.460318888785, 15440.691186176438, 908.6002159050129, 919.9954000229956, 921.5254144115786, 925.7500474871747, 926.2219735422277, 9110.908890911007, 9146.725598232064, 9329.90670093304, 9525.523723813782, 9897.455639939728, 361600.0, 362530.0, 554506.0, 564298.0, 568075.0, 61367.693161533905, 63129.0, 63967.36032639707, 64041.35958640447, 64477.35522644714, 1091.3015669971226, 1103.1836441033738, 1134.9659510214706, 1142.5658249865164, 1144.0561536732064, 11804.291742495478, 13654.0, 13969.511067112602, 14191.716165676422, 14549.490767823076, 30341.241468963453, 30574.694253057183, 31378.215544610655, 31426.371472569965, 31901.840490797396, 35266.64733352736, 36011.45982810312, 36038.14088163284, 37163.25673486569, 39657.603423966546, 6923.411510021705, 7110.57336559808, 7199.424046076406, 7209.6395180241825, 7434.996275502955, 10233.437160956219, 10739.838902416626, 11033.172512061466, 11051.72370690739, 11358.09135269193, 9464.810703786023, 9469.451547329969, 9532.04679532069, 9582.329236953625, 9615.615375384907, 8965.237954773916, 9261.073892610955, 9528.475933823705, 9563.330566860253, 9812.116909478182, 9060.546972651473, 9131.634734610541, 9436.669716559887, 9975.152112070555, 10210.132138768287, 7003.4747393944635, 7215.134183897966, 7224.844024955982, 7227.457940654367, 7292.270772922665, 8079.0, 8807.119288071142, 9066.954665226896, 9078.137576930181, 9226.169644731737], "unit": "score", "name": "jquery.html", "value": 7912.211311026677}, {"lowerIsBetter": false, "replicates": [1297.805329200619, 1437.7915202295667, 1443.3937746146614, 1568.5294411676493, 1744.2238203999218, 6651.068850360954, 7532.133804612471, 7693.653785579649, 7709.460337776358, 7715.074191097062, 7317.59753213573, 7438.516496427728, 7457.66440510177, 7483.438742094338, 7504.249575042493, 1952.8535359847997, 1987.165390535971, 2281.498070424504, 2316.5830150572933, 2346.753590872959, 2364.9881750591308, 2373.5608912351186, 2374.192774456684, 2374.287713685896, 2377.8692171930625, 2232.8771917544527, 2279.133929106937, 2279.7150356205475, 2281.7147856517936, 2283.5090455552054, 2244.652078927769, 2263.9434014149615, 2326.5230627721276, 2327.976720232793, 2328.4528135888136, 2309.6535519672016, 2343.121329501437, 2352.5765362234793, 2359.421941624296, 2366.645003249509, 7709.421793365464, 7711.344535714471, 7751.961240193763, 7752.689892404297, 7780.844383112306, 4655.371524844137, 4732.43210814701, 4754.643401744848, 4769.952300476985, 4774.904501909942, 3054.2059064643354, 3089.4747892858045, 3139.8430078496212, 3200.695933886277, 3203.58353414057, 1075.0969185883896, 1842.207850624231, 1895.573495963411, 1899.078946710844, 1936.4965109071602, 9784.0, 9823.263255255884, 9832.950835245849, 9857.950710246547, 9868.161206297473, 3985.3025720498795, 4010.7593544387432, 4047.7571345719352, 4050.6556942660204, 4167.354060120686, 8082.555459449787, 8089.9191008089165, 8091.352691784643, 8095.190480951976, 8095.3523718102415, 4667.743274119956, 4677.32178834074, 4687.789049492781, 4690.577847993629, 4700.2009658358165, 4288.270993931039, 4320.287152619845, 4328.696991210585, 4329.978350108229, 4337.436133302651, 3203.2312245061485, 3254.886078987224, 3257.885973990899, 3553.236054248349, 3614.0603443104983, 1121.6018313498753, 1138.066785236115, 1144.2162118948547, 1148.0413854431476, 1152.0380482297207, 1293.780057390246, 1299.149057367407, 1301.5444594392077, 1302.6287508060348, 1327.4889167670517, 7179.389751871045, 7255.818604534928, 7292.088488938883, 7295.124585049828, 7300.598467084362, 1078.4176544665793, 1079.2175672637275, 1083.090204228452, 1089.6131873185063, 1096.802575536411, 5826.854328641818, 5902.940970590325, 5907.438793314628, 5911.290645122613, 5916.615419997686, 9348.205402540723, 9441.527923603793, 9530.237580993504, 9731.708048758548, 9751.219902407933, 9535.856962145574, 9569.808603827885, 9608.375455595364, 9612.134907858186, 9621.374610650286, 7243.311885370881, 7397.0, 7406.296401841816, 7458.105027396748, 7460.253974602496, 6981.127359080115, 7007.964960175166, 7012.403945664676, 7031.261717519586, 7037.049998250171, 8358.916410836056, 8525.573721314033, 8557.828843423222, 8649.740507784776, 8822.2060014599, 8738.606762695566, 8755.430896991675, 8802.207801297915, 8951.865722014305, 8957.14907083826, 6531.412172904462, 6629.701663425061, 6661.3338666132995, 6662.200535935719, 6665.7668331358855, 6429.099926010269, 6576.605403675795, 7054.435645148478, 7278.927210727825, 7320.853582928418, 6743.494237932273, 6773.830654233487, 6883.965580172067, 6918.93081069203, 6994.510384273052, 6585.209774827052, 6718.193816742022, 6727.663616819237, 6811.284815094542, 6838.760643377657, 6732.192136943598, 6780.796576102724, 6781.0, 6783.559068660521, 6785.371510837264, 6012.729427175875, 6019.638821670714, 6027.57806953509, 6107.053406721965, 6307.369263073656, 6405.935940640534, 6407.551471397144, 6460.806175814733, 6468.256150542559, 6560.475161986934], "unit": "score", "name": "mootools.html", "value": 4499.712384496652}, {"lowerIsBetter": false, "replicates": [324.05376301200494, 333.80472423632176, 335.4331180305285, 347.7548328428458, 352.62093249756504, 5625.6905870177125, 5785.161151633016, 5798.82603521895, 5888.735006924688, 5891.145783861338, 5563.969151259791, 5742.397048309919, 5745.0, 5758.568107391941, 5759.395263497336, 4483.910321793563, 4492.910141797162, 4495.370648109268, 4496.213162696531, 4504.797284122206, 4322.351647252905, 4393.209222339993, 4421.579949904753, 4486.125205584913, 4493.370928070073, 4442.3336499525, 4463.6429085673235, 4470.552944705536, 4473.396091527651, 4476.418065651461, 4472.217361961643, 4475.0, 4476.283794592866, 4484.058347746977, 4484.9327260090795, 3957.0503079261057, 3957.6438120569, 3959.1487830116375, 3963.850483359822, 3966.5438474575503, 5385.272988146589, 5533.00405926933, 5539.307586551681, 5542.63972841764, 5576.247206627094, 5159.690418574897, 5165.0, 5169.147090730063, 5172.353455818023, 5175.689458632494, 5814.622049566807, 6140.0789881517685, 6161.661108639023, 6164.167837341991, 6166.445019948226, 4091.2022155679656, 4157.48031496063, 4192.664586833046, 4195.91608167835, 4198.874033778991, 6275.121482992385, 6356.332585078592, 6369.777057802955, 6370.458511026522, 6371.044343348489, 4384.934225986613, 4385.188740083095, 4392.231359512072, 4392.978035109868, 4395.846145384896, 4268.829246830154, 4396.538363471854, 4442.4669039715445, 4444.422225110715, 4447.399601053881, 5080.720560369141, 5085.618578606619, 5088.0587091388215, 5088.363954505687, 5098.362704661918, 6135.877282454326, 6172.290186628506, 6176.0, 6182.474489668429, 6182.752689892354, 1539.499662609634, 1540.0528674864877, 1541.8689411399932, 1542.067049435098, 1544.0426935300186, 1017.6489111256604, 1017.9389236645677, 1040.38617215843, 1047.1361127070197, 1059.8622179116664, 5806.709664516758, 5813.82558523245, 5815.73829177688, 5827.213326200994, 5835.44563266489, 6304.085907543381, 6307.274663413675, 6309.148264984168, 6310.6213627182515, 6318.273398559225, 5813.970930145407, 5816.941830581724, 5818.272715910512, 5819.243498345273, 5820.214271073351, 3289.6052473703307, 3383.018924511913, 3399.218179818606, 3403.387390269775, 3406.880759173417, 6497.480201583862, 6511.544191906616, 6527.314631963671, 6532.934670653232, 6540.476761859135, 6501.707423165969, 6505.121808555785, 6505.544611877123, 6509.8698026040165, 6511.934880651228, 6347.270063942613, 6495.805125846232, 6512.609243445314, 6513.381228783258, 6526.575772574767, 6082.5438092142385, 6218.751249949952, 6290.874182516415, 6298.559100862895, 6310.0, 6127.632342059491, 6255.812325630239, 6278.560500764903, 6282.811515654537, 6288.025356069817, 6539.313372096051, 6548.740684463853, 6558.901616475852, 6627.105340778933, 6639.966800165968, 4303.677224208134, 4358.433403657505, 4387.319965405367, 4389.670774691975, 4392.099619578043, 6315.810525684236, 6343.5876668016435, 6344.968275158594, 6347.746090156526, 6352.333005034405, 6167.537434692326, 6174.691265436621, 6180.289266734383, 6194.4115309045565, 6197.504199664107, 6014.57897947157, 6147.877042459215, 6156.476699480594, 6168.352323006199, 6168.444839964424, 6034.24571928509, 6045.1234570987845, 6046.54650901193, 6062.90905636407, 6069.150318955261, 6191.25704915413, 6191.5665903388135, 6192.969035154795, 6198.2252218472695, 6198.566100372931, 5940.46535811779, 6041.909371359346, 6049.909251361321, 6056.121862329849, 6060.060690592965], "unit": "score", "name": "prototype.html", "value": 4635.2775038105965}, {"lowerIsBetter": false, "replicates": [715.4884257755705, 774.0749803984241, 792.3344390711801, 805.4040010392304, 853.7182729699202, 13446.260455674934, 13728.725425491484, 13752.793708094387, 13753.999999999987, 13761.518346857862, 12479.438425270862, 12887.67780805478, 12888.935555322234, 12916.031297652667, 12951.158174718637, 627.4603840696997, 658.8451713847242, 769.872970959791, 771.3559178086291, 800.2397722163938, 779.6413649721135, 790.731151408521, 792.4254915186501, 794.5550491724624, 796.8167321516025, 835.1314632781899, 837.8240569480416, 838.2162677896156, 838.4466252273501, 838.8322335532918, 655.5869802024718, 684.4353408438034, 813.780279324582, 828.6933834481281, 831.6423937706784, 603.5262319079502, 608.3642593489814, 608.6804427675506, 608.7291155435832, 608.7352001879196, 13379.063465557414, 13433.261170635611, 13443.798343024862, 13454.461821527128, 13468.057235993485, 12591.559295424708, 13117.540886068942, 13304.201747895157, 13394.732105357838, 13423.66440838977, 10483.161347092215, 10527.684169474927, 10583.259171857973, 10599.788004239948, 10625.096866766335, 3362.697357237836, 3429.4341433663417, 3461.9826900865587, 3540.238848647553, 3540.2565461253166, 44828.3275750864, 44973.32540011902, 44983.77508112471, 45473.31790023152, 46475.999999999665, 9471.122371978438, 9481.336306458481, 9508.334416590911, 9564.378315409476, 9619.759506012406, 18390.632187356445, 18457.90771046136, 18463.53841153982, 18488.983105929303, 18497.445076647724, 7447.776566703008, 7575.128860181039, 7584.317411432887, 7625.885611715828, 7700.306972372401, 4304.354346847936, 4371.344298355272, 4383.298672212431, 4397.31841564558, 4416.712913660602, 3079.076277116856, 3099.7520198384077, 3100.2714362124884, 3108.0, 3111.9066428007195, 559.4712996218616, 567.324883388766, 573.0086949577171, 581.2298704216929, 588.5762251179144, 539.3204562251591, 595.7259660556106, 630.6531407725732, 666.4834753066413, 666.986660266792, 7999.920000799918, 8157.75526734199, 8210.384221183434, 8873.423227490193, 9140.360174787702, 498.3645851539244, 578.9102689083198, 606.2270604978687, 619.9297017515246, 630.5680608782999, 3772.660460558563, 3789.1474418256225, 3847.0759824978923, 4062.431259623596, 4144.7513149211145, 46237.76881115573, 47346.0, 47549.28676069862, 47611.285830712564, 48079.0, 47371.289430658566, 47587.0, 47616.0, 48246.75876620664, 48408.27387589189, 42240.366394504104, 43366.7831660846, 43886.56113438889, 44003.77998109989, 44112.117757644024, 7870.763877083697, 8034.15641357649, 8262.628181731956, 8321.625526851427, 8495.108013658724, 32972.1756956078, 33407.665923341425, 33546.496802547495, 33613.0, 33801.323973520884, 39129.6087039126, 40030.0, 41521.79239103785, 41979.37030944477, 44303.55696442995, 10021.448820314952, 10215.795684086424, 10415.270931034755, 10553.525091370753, 10690.89309106899, 11202.192599975084, 11439.0, 11574.247673901169, 11648.941755291507, 12002.519899203933, 10740.30188037775, 11072.391018493738, 11144.275622084539, 11297.152713546353, 11628.825567616323, 10726.892731072901, 11068.28056176346, 11259.380734059705, 11279.09767218604, 11589.6523104307, 10516.57933682644, 10942.124630029737, 10981.835272471078, 11065.170112241452, 11363.715907102389, 8348.87476687838, 8537.53043582609, 8628.137186281321, 8677.566121693764, 8890.955545222232, 8155.83688326242, 8667.306615470621, 8878.422902511316, 8979.595918183566, 9076.41003334781], "unit": "score", "name": "yui.html", "value": 6073.55611450992}], "name": "dromaeo_css", "value": 6777.060060139256}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 105.0, 108.0, 110.0, 110.0, 99.0, 110.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 108.0}, {"lowerIsBetter": true, "replicates": [150.0, 132.0, 158.0, 167.0, 123.0, 155.0, 162.0, 132.0, 175.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 148.1}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 161.0, 160.0, 161.0, 159.0, 163.0, 159.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 120.0, 94.0, 70.0, 71.0, 72.0, 110.0, 94.0, 72.0], "unit": "score", "name": "audio-fft", "value": 84.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 141.0, 96.0, 97.0, 97.0, 140.0, 95.0, 96.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 108.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 97.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [58.0, 54.0, 54.0, 54.0, 54.0, 54.0, 56.0, 65.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.4}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 66.0, 66.0, 67.0, 67.0, 66.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.7}, {"lowerIsBetter": true, "replicates": [80.0, 79.0, 88.0, 82.0, 82.0, 81.0, 85.0, 81.0, 83.0, 90.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [112.0, 118.0, 122.0, 123.0, 120.0, 116.0, 126.0, 113.0, 120.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 118.4}, {"lowerIsBetter": true, "replicates": [144.0, 137.0, 144.0, 151.0, 144.0, 133.0, 146.0, 139.0, 141.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.0}, {"lowerIsBetter": true, "replicates": [68.0, 65.0, 67.0, 64.0, 67.0, 70.0, 67.0, 74.0, 65.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1493.9}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.88918558077435], "unit": "score", "name": "Richards", "value": 211.52958400000006}, {"lowerIsBetter": false, "replicates": [194.55252918287937], "unit": "score", "name": "DeltaBlue", "value": 339.84651999999994}, {"lowerIsBetter": false, "replicates": [282.88543140028287], "unit": "score", "name": "Encrypt", "value": 940.9498350000002}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [1098.901098901099], "unit": "score", "name": "RayTrace", "value": 673.3899900000001}, {"lowerIsBetter": false, "replicates": [792.3930269413629], "unit": "score", "name": "Earley", "value": 841.0763060000003}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [42729.166666666664], "unit": "score", "name": "RegExp", "value": 21.319980497318397}, {"lowerIsBetter": false, "replicates": [599.1611743559017], "unit": "score", "name": "Splay", "value": 136.00847899999997}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19928.638624387055}]} 05:32:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19928.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1493.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6777.06"}}} 05:32:47 INFO - Return code: 0 05:32:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:32:47 INFO - # TBPL SUCCESS # 05:32:47 INFO - Running post-action listener: _resource_record_post_action 05:32:47 INFO - Running post-run listener: _resource_record_post_run 05:32:48 INFO - Total resource usage - Wall time: 1229s; CPU: 13.0%; Read bytes: 16384; Write bytes: 541585408; Read time: 40; Write time: 327096 05:32:48 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 173600768; Read time: 0; Write time: 123260 05:32:49 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 16384; Write bytes: 302247936; Read time: 40; Write time: 168656 05:32:49 INFO - Running post-run listener: _upload_blobber_files 05:32:49 INFO - Blob upload gear active. 05:32:49 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:32:49 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 05:32:49 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:32:49 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:32:49 INFO - (blobuploader) - INFO - Open directory for files ... 05:32:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:32:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:32:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:50 INFO - (blobuploader) - INFO - Done attempting. 05:32:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:32:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:32:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:51 INFO - (blobuploader) - INFO - Done attempting. 05:32:51 INFO - (blobuploader) - INFO - Iteration through files over. 05:32:51 INFO - Return code: 0 05:32:51 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:32:51 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:32:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51de2e914a849c4d77da4fc42e033c7c2b4f474a12e5845a08cfba9c39910f67c34967c728a480e191df55bcda8e1fbc0756c8dbfa8989c0b6526966900b4e41", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67e58ec5b4c188140f80bd9847c804cd8d52942bf96a3f99535db191dab1b9ae096a54c48559e138da467d189f1756ba3829bcc3bed87dae8114dddf2c5303ca"} 05:32:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:32:51 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:32:51 INFO - Contents: 05:32:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51de2e914a849c4d77da4fc42e033c7c2b4f474a12e5845a08cfba9c39910f67c34967c728a480e191df55bcda8e1fbc0756c8dbfa8989c0b6526966900b4e41", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67e58ec5b4c188140f80bd9847c804cd8d52942bf96a3f99535db191dab1b9ae096a54c48559e138da467d189f1756ba3829bcc3bed87dae8114dddf2c5303ca"} 05:32:51 INFO - Copying logs to upload dir... 05:32:51 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1280.856982 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2016-01-14 05:32:51.076119) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 05:32:51.080011) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/51de2e914a849c4d77da4fc42e033c7c2b4f474a12e5845a08cfba9c39910f67c34967c728a480e191df55bcda8e1fbc0756c8dbfa8989c0b6526966900b4e41", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67e58ec5b4c188140f80bd9847c804cd8d52942bf96a3f99535db191dab1b9ae096a54c48559e138da467d189f1756ba3829bcc3bed87dae8114dddf2c5303ca"} build_url:https://queue.taskcluster.net/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/LSvEojiXQSuNJr8u-9WGXA/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/Fx-Team/sha512/51de2e914a849c4d77da4fc42e033c7c2b4f474a12e5845a08cfba9c39910f67c34967c728a480e191df55bcda8e1fbc0756c8dbfa8989c0b6526966900b4e41", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/67e58ec5b4c188140f80bd9847c804cd8d52942bf96a3f99535db191dab1b9ae096a54c48559e138da467d189f1756ba3829bcc3bed87dae8114dddf2c5303ca"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 05:32:51.105444) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:32:51.105846) ========= 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=aa08bb06ff6271ef470a76a4000001be-1452775977.144104-1701841605 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004553 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:32:51.189035) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 05:32:51.189436) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 05:32:51.189839) ========= ========= Total master_lag: 0.21 =========