builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-026 starttime: 1452777084.81 results: success (0) buildid: 20160114023006 builduid: 5e5d9b44991e4f359bc89602a2a91fff revision: b4b8a8dd9ce8c2dad00cf8b134b2fe856ec572a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:24.811461) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:24.811871) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:24.812344) ========= 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=41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006371 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:24.851021) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:24.855732) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:24.876243) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:24.876502) ========= 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=41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:24.925911) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:24.926221) ========= 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:24.926575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:24.926843) ========= 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=41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-14 05:11:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 75.0M=0s 2016-01-14 05:11:25 (75.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157716 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:25.099781) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:25.103112) ========= 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=41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023370 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:25.152834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-14 05:11:25.156241) ========= 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=41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-14 05:11:25,351 truncating revision to first 12 chars 2016-01-14 05:11:25,351 Setting DEBUG logging. 2016-01-14 05:11:25,351 attempt 1/10 2016-01-14 05:11:25,351 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:26,640 unpacking tar archive at: fx-team-b4b8a8dd9ce8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.616246 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-14 05:11:26.788446) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:26.788761) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:26.802576) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-14 05:11:26.802894) ========= 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:26.803304) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-14 05:11:26.803588) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:11:27 INFO - MultiFileLogger online at 20160114 05:11:27 in /builds/slave/test-pgo 05:11:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:11:27 INFO - {'append_to_log': False, 05:11:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:11:27 INFO - 'blob_upload_branch': 'Fx-Team', 05:11:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:11:27 INFO - 'branch': 'Fx-Team', 05:11:27 INFO - 'buildbot_json_path': 'buildprops.json', 05:11:27 INFO - 'config_files': ('talos/linux_config.py',), 05:11:27 INFO - 'default_actions': ('clobber', 05:11:27 INFO - 'read-buildbot-config', 05:11:27 INFO - 'download-and-extract', 05:11:27 INFO - 'populate-webroot', 05:11:27 INFO - 'create-virtualenv', 05:11:27 INFO - 'install', 05:11:27 INFO - 'run-tests'), 05:11:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:11:27 INFO - 'download_minidump_stackwalk': True, 05:11:27 INFO - 'download_symbols': 'ondemand', 05:11:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:11:27 INFO - 'tooltool.py': '/tools/tooltool.py', 05:11:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:11:27 INFO - '/tools/misc-python/virtualenv.py')}, 05:11:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:11:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:11:27 INFO - 'installer_path': 'installer.exe', 05:11:27 INFO - 'log_level': 'info', 05:11:27 INFO - 'log_name': 'talos', 05:11:27 INFO - 'log_to_console': True, 05:11:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:11:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:11:27 INFO - 'opt_config_files': (), 05:11:27 INFO - 'pip_index': False, 05:11:27 INFO - 'sps_profile': False, 05:11:27 INFO - 'sps_profile_interval': 0, 05:11:27 INFO - 'suite': 'dromaeojs-e10s', 05:11:27 INFO - 'system_bits': '32', 05:11:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:11:27 INFO - 'title': 'talos-linux64-ix-026', 05:11:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:11:27 INFO - 'use_talos_json': True, 05:11:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:11:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:11:27 INFO - 'work_dir': 'build'} 05:11:27 INFO - ##### 05:11:27 INFO - ##### Running clobber step. 05:11:27 INFO - ##### 05:11:27 INFO - Running pre-action listener: _resource_record_pre_action 05:11:27 INFO - Running main action method: clobber 05:11:27 INFO - rmtree: /builds/slave/test-pgo/build 05:11:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:11:28 INFO - Running post-action listener: _resource_record_post_action 05:11:28 INFO - ##### 05:11:28 INFO - ##### Running read-buildbot-config step. 05:11:28 INFO - ##### 05:11:28 INFO - Running pre-action listener: _resource_record_pre_action 05:11:28 INFO - Running main action method: read_buildbot_config 05:11:28 INFO - Using buildbot properties: 05:11:28 INFO - { 05:11:28 INFO - "project": "", 05:11:28 INFO - "product": "firefox", 05:11:28 INFO - "script_repo_revision": "production", 05:11:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 05:11:28 INFO - "repository": "", 05:11:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 05:11:28 INFO - "buildid": "20160114023006", 05:11:28 INFO - "pgo_build": "True", 05:11:28 INFO - "basedir": "/builds/slave/test-pgo", 05:11:28 INFO - "buildnumber": 447, 05:11:28 INFO - "slavename": "talos-linux64-ix-026", 05:11:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:11:28 INFO - "platform": "ubuntu64_hw", 05:11:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:11:28 INFO - "branch": "fx-team", 05:11:28 INFO - "repo_path": "integration/fx-team", 05:11:28 INFO - "revision": "b4b8a8dd9ce8c2dad00cf8b134b2fe856ec572a4", 05:11:28 INFO - "stage_platform": "linux64-pgo", 05:11:28 INFO - "builduid": "5e5d9b44991e4f359bc89602a2a91fff", 05:11:28 INFO - "slavebuilddir": "test" 05:11:28 INFO - } 05:11:28 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:28 INFO - Running post-action listener: _resource_record_post_action 05:11:28 INFO - ##### 05:11:28 INFO - ##### Running download-and-extract step. 05:11:28 INFO - ##### 05:11:28 INFO - Running pre-action listener: _resource_record_pre_action 05:11:28 INFO - Running main action method: download_and_extract 05:11:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:28 INFO - https://queue.taskcluster.net/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:11:28 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:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LSvEojiXQSuNJr8u-9WGXA/artifacts/public/build/test_packages.json 05:11:28 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:28 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:29 INFO - Downloaded 1448 bytes. 05:11:29 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:11:29 INFO - Using the following test package requirements: 05:11:29 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:29 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:11:29 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:11:29 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:29 INFO - u'jsshell-linux-x86_64.zip'], 05:11:29 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:11:29 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:29 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:11:29 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:11:29 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:11:29 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:29 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:29 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:11:29 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:11:29 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:29 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:29 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:29 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:29 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:29 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:32 INFO - Downloaded 24030981 bytes. 05:11:32 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:32 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:11:32 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:33 INFO - Return code: 0 05:11:33 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:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:33 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:33 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:33 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:33 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:33 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:41 INFO - Downloaded 24030981 bytes. 05:11:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:11:41 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:11:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:11:42 INFO - Return code: 0 05:11:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:42 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:42 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:42 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:42 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:42 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:45 INFO - Downloaded 11132144 bytes. 05:11:45 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:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:45 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:45 INFO - Return code: 0 05:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:45 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:45 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:45 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:45 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:45 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:48 INFO - Downloaded 55874894 bytes. 05:11:48 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:48 INFO - mkdir: /builds/slave/test-pgo/properties 05:11:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:11:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:11:48 INFO - Contents: 05:11:48 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:48 INFO - Running post-action listener: _resource_record_post_action 05:11:48 INFO - Running post-action listener: set_extra_try_arguments 05:11:48 INFO - ##### 05:11:48 INFO - ##### Running populate-webroot step. 05:11:48 INFO - ##### 05:11:48 INFO - Running pre-action listener: _resource_record_pre_action 05:11:48 INFO - Running main action method: populate_webroot 05:11:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:48 INFO - '--tppagecycles', 05:11:48 INFO - '7'], 05:11:48 INFO - 'tests': ['tsvgm']}}, 05:11:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:11:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:11:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:11:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:11:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:11:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:11:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:48 INFO - 'talos_options': ['--e10s'], 05:11:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:48 INFO - 'tests': ['damp', 'tps']}, 05:11:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:48 INFO - 'talos_options': ['--e10s'], 05:11:48 INFO - 'tests': ['damp', 'tps']}, 05:11:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:11:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:48 INFO - 'other': {'tests': ['a11yr', 05:11:48 INFO - 'ts_paint', 05:11:48 INFO - 'tpaint', 05:11:48 INFO - 'sessionrestore', 05:11:48 INFO - 'sessionrestore_no_auto_restore']}, 05:11:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:11:48 INFO - 'tests': ['a11yr', 05:11:48 INFO - 'ts_paint', 05:11:48 INFO - 'tpaint', 05:11:48 INFO - 'sessionrestore', 05:11:48 INFO - 'sessionrestore_no_auto_restore']}, 05:11:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:11:48 INFO - 'tests': ['a11yr', 05:11:48 INFO - 'ts_paint', 05:11:48 INFO - 'tpaint', 05:11:48 INFO - 'sessionrestore', 05:11:48 INFO - 'sessionrestore_no_auto_restore']}, 05:11:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:11:48 INFO - 'tests': ['a11yr', 05:11:48 INFO - 'ts_paint', 05:11:48 INFO - 'tpaint', 05:11:48 INFO - 'sessionrestore', 05:11:48 INFO - 'sessionrestore_no_auto_restore']}, 05:11:48 INFO - 'other_l64': {'tests': ['a11yr', 05:11:48 INFO - 'ts_paint', 05:11:48 INFO - 'tpaint', 05:11:48 INFO - 'sessionrestore', 05:11:48 INFO - 'sessionrestore_no_auto_restore']}, 05:11:48 INFO - 'other_nol64': {'tests': ['a11yr', 05:11:48 INFO - 'ts_paint', 05:11:48 INFO - 'tpaint', 05:11:48 INFO - 'sessionrestore', 05:11:48 INFO - 'sessionrestore_no_auto_restore']}, 05:11:48 INFO - 'svgr': {'tests': ['tsvgx', 05:11:48 INFO - 'tsvgr_opacity', 05:11:48 INFO - 'tart', 05:11:48 INFO - 'tscrollx', 05:11:48 INFO - 'cart']}, 05:11:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:11:48 INFO - 'tests': ['tsvgx', 05:11:48 INFO - 'tsvgr_opacity', 05:11:48 INFO - 'tart', 05:11:48 INFO - 'tscrollx', 05:11:48 INFO - 'cart']}, 05:11:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:48 INFO - 'tests': ['tp5o']}, 05:11:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:48 INFO - 'talos_options': ['--e10s'], 05:11:48 INFO - 'tests': ['tp5o']}, 05:11:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:48 INFO - 'talos_options': ['--xperf_path', 05:11:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:48 INFO - 'tests': ['tp5n']}, 05:11:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:48 INFO - 'talos_options': ['--e10s', 05:11:48 INFO - '--xperf_path', 05:11:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:48 INFO - 'tests': ['tp5n']}}, 05:11:48 INFO - 'talos.zip': {'path': '', 05:11:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:48 INFO - Running post-action listener: _resource_record_post_action 05:11:48 INFO - ##### 05:11:48 INFO - ##### Running create-virtualenv step. 05:11:48 INFO - ##### 05:11:48 INFO - Running pre-action listener: _resource_record_pre_action 05:11:48 INFO - Running main action method: create_virtualenv 05:11:48 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:11:48 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:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:11:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:48 INFO - Using real prefix '/usr' 05:11:48 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:11:49 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:50 INFO - Installing pip.................done. 05:11:51 INFO - Return code: 0 05:11:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f48aa7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2877630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2908840>, '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 0x28756b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875b60>, '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': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', '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:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:11:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:11:51 INFO - Using env: {'DISPLAY': ':0', 05:11:51 INFO - 'HOME': '/home/cltbld', 05:11:51 INFO - 'LANG': 'en_US.UTF-8', 05:11:51 INFO - 'LANGUAGE': 'en_US:en', 05:11:51 INFO - 'LOGNAME': 'cltbld', 05:11:51 INFO - 'MAIL': '/var/mail/cltbld', 05:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:51 INFO - 'MOZ_NO_REMOTE': '1', 05:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:51 INFO - 'NO_EM_RESTART': '1', 05:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:11:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:11:51 INFO - 'SHELL': '/bin/bash', 05:11:51 INFO - 'SHLVL': '1', 05:11:51 INFO - 'TERM': 'linux', 05:11:51 INFO - 'TMOUT': '86400', 05:11:51 INFO - 'USER': 'cltbld', 05:11:51 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', 05:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:51 INFO - '_': '/tools/buildbot/bin/python'} 05:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:51 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:51 INFO - Cleaning up... 05:11:51 INFO - Return code: 0 05:11:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f48aa7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2877630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2908840>, '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 0x28756b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875b60>, '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': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', '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:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:11:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:11:51 INFO - Using env: {'DISPLAY': ':0', 05:11:51 INFO - 'HOME': '/home/cltbld', 05:11:51 INFO - 'LANG': 'en_US.UTF-8', 05:11:51 INFO - 'LANGUAGE': 'en_US:en', 05:11:51 INFO - 'LOGNAME': 'cltbld', 05:11:51 INFO - 'MAIL': '/var/mail/cltbld', 05:11:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:51 INFO - 'MOZ_NO_REMOTE': '1', 05:11:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:51 INFO - 'NO_EM_RESTART': '1', 05:11:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:11:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:11:51 INFO - 'SHELL': '/bin/bash', 05:11:51 INFO - 'SHLVL': '1', 05:11:51 INFO - 'TERM': 'linux', 05:11:51 INFO - 'TMOUT': '86400', 05:11:51 INFO - 'USER': 'cltbld', 05:11:51 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', 05:11:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:51 INFO - '_': '/tools/buildbot/bin/python'} 05:11:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:51 INFO - Downloading/unpacking psutil>=0.7.1 05:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:11:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:11:53 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:11:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:53 INFO - Installing collected packages: psutil 05:11:53 INFO - Running setup.py install for psutil 05:11:53 INFO - building 'psutil._psutil_linux' extension 05:11:53 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:11:53 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:11:53 INFO - building 'psutil._psutil_posix' extension 05:11:53 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:11:53 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:11:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:53 INFO - Successfully installed psutil 05:11:53 INFO - Cleaning up... 05:11:53 INFO - Return code: 0 05:11:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:53 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 0x7f48aa7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2877630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2908840>, '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 0x28756b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875b60>, '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': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', '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:53 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:11:53 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:11:53 INFO - Using env: {'DISPLAY': ':0', 05:11:53 INFO - 'HOME': '/home/cltbld', 05:11:53 INFO - 'LANG': 'en_US.UTF-8', 05:11:53 INFO - 'LANGUAGE': 'en_US:en', 05:11:53 INFO - 'LOGNAME': 'cltbld', 05:11:53 INFO - 'MAIL': '/var/mail/cltbld', 05:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:53 INFO - 'MOZ_NO_REMOTE': '1', 05:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:53 INFO - 'NO_EM_RESTART': '1', 05:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:11:53 INFO - 'PWD': '/builds/slave/test-pgo', 05:11:53 INFO - 'SHELL': '/bin/bash', 05:11:53 INFO - 'SHLVL': '1', 05:11:53 INFO - 'TERM': 'linux', 05:11:53 INFO - 'TMOUT': '86400', 05:11:53 INFO - 'USER': 'cltbld', 05:11:53 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', 05:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:53 INFO - '_': '/tools/buildbot/bin/python'} 05:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:11:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:11:55 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:11:55 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:11:55 INFO - Installing collected packages: mozsystemmonitor 05:11:55 INFO - Running setup.py install for mozsystemmonitor 05:11:55 INFO - Successfully installed mozsystemmonitor 05:11:55 INFO - Cleaning up... 05:11:55 INFO - Return code: 0 05:11:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f48aa7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2877630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2908840>, '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 0x28756b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875b60>, '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': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', '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:55 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:11:55 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:11:55 INFO - Using env: {'DISPLAY': ':0', 05:11:55 INFO - 'HOME': '/home/cltbld', 05:11:55 INFO - 'LANG': 'en_US.UTF-8', 05:11:55 INFO - 'LANGUAGE': 'en_US:en', 05:11:55 INFO - 'LOGNAME': 'cltbld', 05:11:55 INFO - 'MAIL': '/var/mail/cltbld', 05:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:55 INFO - 'MOZ_NO_REMOTE': '1', 05:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:55 INFO - 'NO_EM_RESTART': '1', 05:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:11:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:11:55 INFO - 'SHELL': '/bin/bash', 05:11:55 INFO - 'SHLVL': '1', 05:11:55 INFO - 'TERM': 'linux', 05:11:55 INFO - 'TMOUT': '86400', 05:11:55 INFO - 'USER': 'cltbld', 05:11:55 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', 05:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:55 INFO - '_': '/tools/buildbot/bin/python'} 05:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:56 INFO - Downloading/unpacking blobuploader==1.2.4 05:11:56 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:56 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:56 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:56 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:56 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:56 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:57 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:11:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:11:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:11:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:11:58 INFO - Downloading docopt-0.6.1.tar.gz 05:11:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:11:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:58 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:58 INFO - Running setup.py install for blobuploader 05:11:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:58 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:11:58 INFO - Running setup.py install for requests 05:11:58 INFO - Running setup.py install for docopt 05:11:59 INFO - Successfully installed blobuploader requests docopt 05:11:59 INFO - Cleaning up... 05:11:59 INFO - Return code: 0 05:11:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:59 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 0x7f48aa7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2877630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2908840>, '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 0x28756b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875b60>, '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': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', '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:59 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:11:59 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:11:59 INFO - Using env: {'DISPLAY': ':0', 05:11:59 INFO - 'HOME': '/home/cltbld', 05:11:59 INFO - 'LANG': 'en_US.UTF-8', 05:11:59 INFO - 'LANGUAGE': 'en_US:en', 05:11:59 INFO - 'LOGNAME': 'cltbld', 05:11:59 INFO - 'MAIL': '/var/mail/cltbld', 05:11:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:59 INFO - 'MOZ_NO_REMOTE': '1', 05:11:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:59 INFO - 'NO_EM_RESTART': '1', 05:11:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:11:59 INFO - 'PWD': '/builds/slave/test-pgo', 05:11:59 INFO - 'SHELL': '/bin/bash', 05:11:59 INFO - 'SHLVL': '1', 05:11:59 INFO - 'TERM': 'linux', 05:11:59 INFO - 'TMOUT': '86400', 05:11:59 INFO - 'USER': 'cltbld', 05:11:59 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', 05:11:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:59 INFO - '_': '/tools/buildbot/bin/python'} 05:11:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:11:59 INFO - Running setup.py (path:/tmp/pip-mwLd2r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:11:59 INFO - Running setup.py (path:/tmp/pip-_izUJz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:11:59 INFO - Running setup.py (path:/tmp/pip-BbQZec-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:11:59 INFO - Running setup.py (path:/tmp/pip-PKeCfj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:11:59 INFO - Running setup.py (path:/tmp/pip-x4bsWD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:11:59 INFO - Running setup.py (path:/tmp/pip-suowao-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:11:59 INFO - Running setup.py (path:/tmp/pip-1OUBbW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:11:59 INFO - Running setup.py (path:/tmp/pip-nUiqNe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:11:59 INFO - Running setup.py (path:/tmp/pip-SOzo7l-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:11:59 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:11:59 INFO - Running setup.py (path:/tmp/pip-nvphcY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:12:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:12:00 INFO - Running setup.py (path:/tmp/pip-GCgoWC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:12:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:12:00 INFO - Running setup.py (path:/tmp/pip-ZuLcxP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:12:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:12:00 INFO - Running setup.py (path:/tmp/pip-6andSR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:12:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:12:00 INFO - Running setup.py (path:/tmp/pip-yi00PJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:12:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:12:00 INFO - Running setup.py (path:/tmp/pip-9pspjn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:12:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:12:00 INFO - Running setup.py (path:/tmp/pip-02XFHk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:12:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:12:00 INFO - Running setup.py (path:/tmp/pip-yceYxc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:12:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:12:00 INFO - Running setup.py install for manifestparser 05:12:00 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:12:00 INFO - Running setup.py install for mozcrash 05:12:00 INFO - Running setup.py install for mozdebug 05:12:00 INFO - Running setup.py install for mozdevice 05:12:00 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:12:00 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:12:00 INFO - Running setup.py install for mozfile 05:12:01 INFO - Running setup.py install for mozhttpd 05:12:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:12:01 INFO - Running setup.py install for mozinfo 05:12:01 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:12:01 INFO - Running setup.py install for mozInstall 05:12:01 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:12:01 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:12:01 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:12:01 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:12:01 INFO - Running setup.py install for mozleak 05:12:01 INFO - Running setup.py install for mozlog 05:12:01 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:12:01 INFO - Running setup.py install for moznetwork 05:12:01 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:12:01 INFO - Running setup.py install for mozprocess 05:12:01 INFO - Running setup.py install for mozprofile 05:12:01 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:12:01 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:12:01 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:12:01 INFO - Running setup.py install for mozrunner 05:12:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:12:02 INFO - Running setup.py install for mozscreenshot 05:12:02 INFO - Running setup.py install for moztest 05:12:02 INFO - Running setup.py install for mozversion 05:12:02 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:12:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:12:02 INFO - Cleaning up... 05:12:02 INFO - Return code: 0 05:12:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:02 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f48aa7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2877630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2908840>, '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 0x28756b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875b60>, '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': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', '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:02 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:02 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:02 INFO - Using env: {'DISPLAY': ':0', 05:12:02 INFO - 'HOME': '/home/cltbld', 05:12:02 INFO - 'LANG': 'en_US.UTF-8', 05:12:02 INFO - 'LANGUAGE': 'en_US:en', 05:12:02 INFO - 'LOGNAME': 'cltbld', 05:12:02 INFO - 'MAIL': '/var/mail/cltbld', 05:12:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:02 INFO - 'MOZ_NO_REMOTE': '1', 05:12:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:02 INFO - 'NO_EM_RESTART': '1', 05:12:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:12:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:12:02 INFO - 'SHELL': '/bin/bash', 05:12:02 INFO - 'SHLVL': '1', 05:12:02 INFO - 'TERM': 'linux', 05:12:02 INFO - 'TMOUT': '86400', 05:12:02 INFO - 'USER': 'cltbld', 05:12:02 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', 05:12:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:02 INFO - '_': '/tools/buildbot/bin/python'} 05:12:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:12:02 INFO - Running setup.py (path:/tmp/pip-xprU5w-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:12:02 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:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:12:02 INFO - Running setup.py (path:/tmp/pip-stpYTn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:12:02 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:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:12:02 INFO - Running setup.py (path:/tmp/pip-A0BPOv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:12:02 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:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:12:02 INFO - Running setup.py (path:/tmp/pip-JTY0D4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:12:02 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:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:12:02 INFO - Running setup.py (path:/tmp/pip-b7uphU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:12:02 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:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:12:02 INFO - Running setup.py (path:/tmp/pip-SAk77r-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:12:02 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:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:12:02 INFO - Running setup.py (path:/tmp/pip-8zZe4L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:12:03 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:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:12:03 INFO - Running setup.py (path:/tmp/pip-xyQoew-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:12:03 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:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:12:03 INFO - Running setup.py (path:/tmp/pip-T_4yD4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:12:03 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:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:12:03 INFO - Running setup.py (path:/tmp/pip-6y6oDW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:12:03 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:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:12:03 INFO - Running setup.py (path:/tmp/pip-6e6zTj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:12:03 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:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:12:03 INFO - Running setup.py (path:/tmp/pip-UUXB2n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:12:03 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:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:12:03 INFO - Running setup.py (path:/tmp/pip-cIbW5h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:12:03 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:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:12:03 INFO - Running setup.py (path:/tmp/pip-59AO92-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:12:03 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:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:12:03 INFO - Running setup.py (path:/tmp/pip-16ebvW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:12:03 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:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:12:03 INFO - Running setup.py (path:/tmp/pip-7l2H7P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:12:03 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:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:12:03 INFO - Running setup.py (path:/tmp/pip-ntNY7n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:12:03 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:03 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:03 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:03 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:03 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:03 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:03 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: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 blessings-1.5.1.tar.gz 05:12:05 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:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:12:05 INFO - Installing collected packages: blessings 05:12:05 INFO - Running setup.py install for blessings 05:12:05 INFO - Successfully installed blessings 05:12:05 INFO - Cleaning up... 05:12:05 INFO - Return code: 0 05:12:05 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:12:05 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:12:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:12:05 INFO - Reading from file tmpfile_stdout 05:12:05 INFO - Current package versions: 05:12:05 INFO - argparse == 1.2.1 05:12:05 INFO - blessings == 1.5.1 05:12:05 INFO - blobuploader == 1.2.4 05:12:05 INFO - docopt == 0.6.1 05:12:05 INFO - manifestparser == 1.1 05:12:05 INFO - mozInstall == 1.12 05:12:05 INFO - mozcrash == 0.16 05:12:05 INFO - mozdebug == 0.1 05:12:05 INFO - mozdevice == 0.48 05:12:05 INFO - mozfile == 1.2 05:12:05 INFO - mozhttpd == 0.7 05:12:05 INFO - mozinfo == 0.9 05:12:05 INFO - mozleak == 0.1 05:12:05 INFO - mozlog == 3.1 05:12:05 INFO - moznetwork == 0.27 05:12:05 INFO - mozprocess == 0.22 05:12:05 INFO - mozprofile == 0.28 05:12:05 INFO - mozrunner == 6.11 05:12:05 INFO - mozscreenshot == 0.1 05:12:05 INFO - mozsystemmonitor == 0.0 05:12:05 INFO - moztest == 0.7 05:12:05 INFO - mozversion == 1.4 05:12:05 INFO - psutil == 3.1.1 05:12:05 INFO - requests == 1.2.3 05:12:05 INFO - wsgiref == 0.1.2 05:12:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:05 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7f48aa7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2877630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2908840>, '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 0x28756b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875b60>, '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': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', '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:05 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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:05 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/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:05 INFO - Using env: {'DISPLAY': ':0', 05:12:05 INFO - 'HOME': '/home/cltbld', 05:12:05 INFO - 'LANG': 'en_US.UTF-8', 05:12:05 INFO - 'LANGUAGE': 'en_US:en', 05:12:05 INFO - 'LOGNAME': 'cltbld', 05:12:05 INFO - 'MAIL': '/var/mail/cltbld', 05:12:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:05 INFO - 'MOZ_NO_REMOTE': '1', 05:12:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:05 INFO - 'NO_EM_RESTART': '1', 05:12:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:12:05 INFO - 'PWD': '/builds/slave/test-pgo', 05:12:05 INFO - 'SHELL': '/bin/bash', 05:12:05 INFO - 'SHLVL': '1', 05:12:05 INFO - 'TERM': 'linux', 05:12:05 INFO - 'TMOUT': '86400', 05:12:05 INFO - 'USER': 'cltbld', 05:12:05 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', 05:12:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:05 INFO - '_': '/tools/buildbot/bin/python'} 05:12:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:06 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:06 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:06 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:06 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:06 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:06 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:06 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:06 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:06 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:06 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:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:12:06 INFO - Cleaning up... 05:12:06 INFO - Return code: 0 05:12:06 INFO - Installing jsonschema 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', '--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 0x7f48aa7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2877630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2908840>, '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 0x28756b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875b60>, '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': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', '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', '--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:06 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: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': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', 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 - Downloading/unpacking jsonschema 05:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:12:08 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:08 INFO - Downloading/unpacking functools32 (from jsonschema) 05:12:08 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:08 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:08 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:08 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:08 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:08 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:08 INFO - Downloading functools32-3.2.3-2.tar.gz 05:12:08 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:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:12:08 INFO - warning: no files found matching '*.txt' 05:12:08 INFO - no previously-included directories found matching 'build' 05:12:08 INFO - no previously-included directories found matching 'dist' 05:12:08 INFO - no previously-included directories found matching '.git*' 05:12:08 INFO - Installing collected packages: jsonschema, functools32 05:12:08 INFO - Running setup.py install for functools32 05:12:08 INFO - warning: no files found matching '*.txt' 05:12:08 INFO - no previously-included directories found matching 'build' 05:12:08 INFO - no previously-included directories found matching 'dist' 05:12:08 INFO - no previously-included directories found matching '.git*' 05:12:08 INFO - Successfully installed jsonschema functools32 05:12:08 INFO - Cleaning up... 05:12:08 INFO - Return code: 0 05:12:08 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:08 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f48aa7ddf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a78a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2877630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2908840>, '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 0x28756b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875b60>, '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': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', '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:08 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:08 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:08 INFO - Using env: {'DISPLAY': ':0', 05:12:08 INFO - 'HOME': '/home/cltbld', 05:12:08 INFO - 'LANG': 'en_US.UTF-8', 05:12:08 INFO - 'LANGUAGE': 'en_US:en', 05:12:08 INFO - 'LOGNAME': 'cltbld', 05:12:08 INFO - 'MAIL': '/var/mail/cltbld', 05:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:08 INFO - 'MOZ_NO_REMOTE': '1', 05:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:08 INFO - 'NO_EM_RESTART': '1', 05:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:12:08 INFO - 'PWD': '/builds/slave/test-pgo', 05:12:08 INFO - 'SHELL': '/bin/bash', 05:12:08 INFO - 'SHLVL': '1', 05:12:08 INFO - 'TERM': 'linux', 05:12:08 INFO - 'TMOUT': '86400', 05:12:08 INFO - 'USER': 'cltbld', 05:12:08 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', 05:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:08 INFO - '_': '/tools/buildbot/bin/python'} 05:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:08 INFO - Downloading/unpacking flake8 05:12:08 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:08 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:08 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:08 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:08 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:08 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:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:12:10 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:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:12:10 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:10 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:10 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:10 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:10 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:10 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:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:12:10 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:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:12:10 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:10 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:10 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:10 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:10 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:10 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:10 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:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:12:10 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:10 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:10 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:10 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:10 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:10 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 - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:12:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:12:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:12:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:12:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:12:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:12:11 INFO - no previously-included directories found matching 'docs/_build' 05:12:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:12:11 INFO - Running setup.py install for pep8 05:12:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:12:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:12:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:12:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:12:11 INFO - no previously-included directories found matching 'docs/_build' 05:12:11 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:12:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:12:11 INFO - Cleaning up... 05:12:11 INFO - Return code: 0 05:12:11 INFO - Running post-action listener: _resource_record_post_action 05:12:11 INFO - Running post-action listener: _start_resource_monitoring 05:12:11 INFO - Starting resource monitoring. 05:12:11 INFO - ##### 05:12:11 INFO - ##### Running install step. 05:12:11 INFO - ##### 05:12:11 INFO - Running pre-action listener: _resource_record_pre_action 05:12:11 INFO - Running main action method: install 05:12:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:12:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:12:11 INFO - Reading from file tmpfile_stdout 05:12:11 INFO - Detecting whether we're running mozinstall >=1.0... 05:12:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:12:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:12:11 INFO - Reading from file tmpfile_stdout 05:12:11 INFO - Output received: 05:12:11 INFO - Usage: mozinstall [options] installer 05:12:11 INFO - Options: 05:12:11 INFO - -h, --help show this help message and exit 05:12:11 INFO - -d DEST, --destination=DEST 05:12:11 INFO - Directory to install application into. [default: 05:12:11 INFO - "/builds/slave/test-pgo"] 05:12:11 INFO - --app=APP Application being installed. [default: firefox] 05:12:11 INFO - mkdir: /builds/slave/test-pgo/build/application 05:12:11 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:11 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:27 INFO - Reading from file tmpfile_stdout 05:12:27 INFO - Output received: 05:12:27 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:12:27 INFO - Running post-action listener: _resource_record_post_action 05:12:27 INFO - ##### 05:12:27 INFO - ##### Running run-tests step. 05:12:27 INFO - ##### 05:12:27 INFO - Running pre-action listener: _resource_record_pre_action 05:12:27 INFO - Running main action method: run_tests 05:12:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:12:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:12:27 INFO - Python 2.7.3 05:12:27 INFO - Return code: 0 05:12:27 INFO - grabbing minidump binary from tooltool 05:12:27 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:27 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 0x2908840>, '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 0x28756b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2875b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:12:27 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:27 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:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:12:27 INFO - Return code: 0 05:12:27 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:12:27 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:12:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:12:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:12:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:12:27 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:12:27 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:12:28 INFO - Return code: 0 05:12:28 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-e10s', '--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-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:12:28 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-e10s --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-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:12:28 INFO - Using env: {'DISPLAY': ':0', 05:12:28 INFO - 'HOME': '/home/cltbld', 05:12:28 INFO - 'LANG': 'en_US.UTF-8', 05:12:28 INFO - 'LANGUAGE': 'en_US:en', 05:12:28 INFO - 'LOGNAME': 'cltbld', 05:12:28 INFO - 'MAIL': '/var/mail/cltbld', 05:12:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:12:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:28 INFO - 'MOZ_NO_REMOTE': '1', 05:12:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:12:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:28 INFO - 'NO_EM_RESTART': '1', 05:12:28 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:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:12:28 INFO - 'PWD': '/builds/slave/test-pgo', 05:12:28 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:12:28 INFO - 'SHELL': '/bin/bash', 05:12:28 INFO - 'SHLVL': '1', 05:12:28 INFO - 'TERM': 'linux', 05:12:28 INFO - 'TMOUT': '86400', 05:12:28 INFO - 'USER': 'cltbld', 05:12:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583', 05:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:28 INFO - '_': '/tools/buildbot/bin/python'} 05:12:28 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-e10s', '--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-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:12:28 INFO - mozversion application_buildid: 20160114023006 05:12:28 INFO - mozversion application_changeset: b4b8a8dd9ce8c2dad00cf8b134b2fe856ec572a4 05:12:28 INFO - mozversion application_display_name: Nightly 05:12:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:12:28 INFO - mozversion application_name: Firefox 05:12:28 INFO - mozversion application_remotingname: firefox 05:12:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:12:28 INFO - mozversion application_vendor: Mozilla 05:12:28 INFO - mozversion application_version: 46.0a1 05:12:28 INFO - mozversion platform_buildid: 20160114023006 05:12:28 INFO - mozversion platform_changeset: b4b8a8dd9ce8c2dad00cf8b134b2fe856ec572a4 05:12:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:12:28 INFO - mozversion platform_version: 46.0a1 05:12:28 INFO - using testdate: 1452777148 05:12:28 INFO - actual date: 1452777148 05:12:28 INFO - starting webserver on 'localhost:55789' 05:12:28 INFO - SUITE-START | Running 3 tests 05:12:28 INFO - TEST-START | dromaeo_css 05:12:28 INFO - operating with platform_type : linux_ 05:12:28 INFO - Initialising browser for dromaeo_css test... 05:12:28 INFO - TEST-INFO | started process 25846 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvTnYQN/profile http://localhost:55789/getInfo.html) 05:12:32 INFO - PROCESS | 25846 | 05:12:32 INFO - PROCESS | 25846 | (process:25932): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:12:33 INFO - PROCESS | 25846 | __metrics Screen width/height:1600/1200 05:12:33 INFO - PROCESS | 25846 | colorDepth:24 05:12:33 INFO - PROCESS | 25846 | Browser inner width/height: 1024/697 05:12:33 INFO - PROCESS | 25846 | __metrics 05:12:33 INFO - PROCESS | 25846 | 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:34 INFO - TEST-INFO | 25846: exit 0 05:12:34 INFO - Browser initialized. 05:12:34 INFO - Running cycle 1/1 for dromaeo_css test... 05:12:34 INFO - TEST-INFO | started process 25981 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvTnYQN/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:35 INFO - PROCESS | 25981 | 05:12:35 INFO - PROCESS | 25981 | (process:26038): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:12:46 INFO - PROCESS | 25981 | RSS: Main: 150630400 05:12:46 INFO - PROCESS | 25981 | 05:13:35 INFO - PROCESS | 25981 | 1452777215748 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:44 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:55789/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55789/tests/dromaeo/cssquery-ext.html) 05:15:45 INFO - PROCESS | 25981 | RSS: Main: 155172864 05:15:45 INFO - PROCESS | 25981 | 05:18:48 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:55789/tests/dromaeo/cssquery-ext.html (next: http://localhost:55789/tests/dromaeo/cssquery-jquery.html) 05:18:48 INFO - PROCESS | 25981 | RSS: Main: 151171072 05:18:48 INFO - PROCESS | 25981 | 05:21:50 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:55789/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55789/tests/dromaeo/cssquery-mootools.html) 05:21:50 INFO - PROCESS | 25981 | RSS: Main: 152059904 05:21:50 INFO - PROCESS | 25981 | 05:24:52 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:55789/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55789/tests/dromaeo/cssquery-prototype.html) 05:24:53 INFO - PROCESS | 25981 | RSS: Main: 151195648 05:24:53 INFO - PROCESS | 25981 | 05:27:55 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:55789/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55789/tests/dromaeo/cssquery-yui.html) 05:27:56 INFO - PROCESS | 25981 | RSS: Main: 151048192 05:27:56 INFO - PROCESS | 25981 | 05:30:58 INFO - PROCESS | 25981 | Cycle 1(1): loaded http://localhost:55789/tests/dromaeo/cssquery-yui.html (next: http://localhost:55789/tests/dromaeo/cssquery-dojo.html) 05:30:58 INFO - PROCESS | 25981 | RSS: Main: 153616384 05:30:58 INFO - PROCESS | 25981 | 05:30:58 INFO - PROCESS | 25981 | __start_tp_report 05:30:58 INFO - PROCESS | 25981 | _x_x_mozilla_page_load 05:30:58 INFO - PROCESS | 25981 | _x_x_mozilla_page_load_details 05:30:58 INFO - PROCESS | 25981 | |i|pagename|runs| 05:30:58 INFO - PROCESS | 25981 | |0;dojo.html;3226.435373809583;3227.9193020174494;3252.4308246056935;3272.476403775396;3273.1980664737143;5241.790328386869;5269.446708095643;5342.866428339294;5349.438308977555;5353.839384818457;5240.764165612547;5270.156774916014;5371.892562148755;5407.3781515125775;5412.134058550623;4801.73590452525;4813.109574728669;4828.155072862252;4872.488388719186;5008.724520151391;4954.653174277802;4973.0551195272965;4978.502149785028;5030.421501527317;5051.166557518023;4783.139034973703;4849.418069831625;4851.830185943475;4958.9008219835405;4982.950170498285;4877.317175595419;4895.510448955111;4904.975475122637;4915.1398505261795;4961.875953101166;4715.764211789431;4896.559309662148;4897.4857639948;4907.067657145131;4979.153543897546;5173.948260517384;5195.480451954812;5232.581393488512;5242.5281724644965;5252.816151434681;5813.82558523245;5831.475167234969;5835.328937172237;5835.416458354173;5837.445442682938;5591.6365436246515;5723.742431590588;5854.2096816930025;5856.912146317809;5872.911906321408;5327.9610475956815;5330.840074797762;5336.67979921206;5336.786528538853;5337.852361742244;5731.254936858182;5767.596268261182;5787.565932555075;5799.33307669615;5821.214136091573;5573.386927437979;5584.553235741212;5588.357338905997;5636.098224284095;5740.024195886709;5724.427557244242;5734.942650573525;5774.335951365647;5774.94225057744;5779.971100144472;5739.282589676291;5748.540116790647;5749.195112684228;5750.166225897222;5752.942470575241;5501;5583.134614134816;5600.831975040755;5604.719764011783;5744.281964754406;4437.001674623249;4441.555844415532;4493.191225579427;4546.88632784183;4590.793414296298;3962.9603703962593;3965.325894597925;3970.980145099256;3978.5822488638855;4011.959880401217;5223.320968274176;5336.359636843526;5352.9732351338;5355.7054362009685;5360.973195134077;5716.657000579979;5737.942620573825;5754.251947246831;5756.079027355687;5765.1928729977835;5455.536279416215;5456.536194423518;5457.590680698963;5464.043792336325;5471.753771080311;4923.433805112386;4931.161702510582;4977.552020318189;4980.078685443204;5013.699178049329;5750.741216645261;5810.825675229666;5865.090910908731;5871.6770577618645;5994.37059108796;5733.971330143323;5759.539236860957;5800.1589769484035;5841.561882858888;5915.91126133117;5883.441073098049;5910.674912879833;5962.135490353788;5962.910556341745;5970.940290597038;5638.407967163553;5640.294963129609;5641.153826925994;5654.123610840326;5718.342390625131;5639.661620302795;5712.914306285492;5713.200151978644;5716.914246286392;5719.342275638355;5548.528375088163;5575.1915972184615;5642.88714225705;5739.770409183586;5781.988152073286;5495.5878309127775;5601.04782187021;5602.663840169603;5608.158776183442;5618.859528511656;5387.326584176978;5492.505674489315;5498.1752737089755;5504.862378440571;5509.173623956439;5520.089185284543;5627.718614069198;5755.65466072037;5759.2512973313205;5805.129230615442;5508.394076651485;5520.337559492887;5522.779088836402;5525.475079867406;5537.778488860562 05:30:58 INFO - PROCESS | 25981 | |1;ext.html;521.7730287325014;538.8760585065435;550.2406678783278;570.3355590736792;623.6164758673411;35038;35509.2898142037;35552.64447355526;35607.2878542429;35689.10777230567;36007.63992360076;36280.092997675005;36281.637183628154;36459.63540364595;36645.816770916106;8205.671773129083;8432.747017589481;8435.578221088952;8442.746717598482;8447.450915690491;8176.795580110515;8357.874631880526;8455.746327610152;8462.3653226008;8484.066752657234;8374.83250334993;8427;8445.746627601182;8483.066862645104;8498.617562209685;8408.117147699495;8434.198751118634;8447.746567602982;8450.450720703166;8454.78863028423;8283.25450709439;8432.45189062709;8439.324854011664;8458.830823383498;8485.66057357705;36203.275934481164;36677;36679.449808252895;36741.44887826685;36867.26265474702;3180.6183258009187;3196.568463257454;3227.8863791991726;3379.493076038589;3462.255615042778;29202;29342.972995945252;29613.851930740424;29631.407371852656;30622.54066189009;3742.3263812513737;3807;3903.1413089120633;3916.5691773904846;3960.6435420812263;220731;220916;221274;221606;223325.99999999837;53083;55015.44984550183;55580.72209639007;55636.443635563126;55652.44347556472;64789;65597.67201163963;65799.67100164469;65993;66312.6684366575;15570.065796052273;15653.373865045498;15721;15763.605909852346;15768.92115539415;12015.759684806255;12016.939915300542;12077.15459917815;12093.334866582247;12099.33453660057;19354.806451935583;19504.804951950584;19587.706184407245;20121.798782012283;20489.897550512153;8043;8076.555789431638;8145.592720364077;8174;8257.917420825836;907.0022974727879;936.817320622472;967.5210770668564;1034.374203606822;1047.9266451348485;28018.159455216377;28333.858330708215;28609.28476788097;28684.282892927844;28788.71211287902;1056.4770438632927;1064.9627263045757;1067.5836423794726;1079.8488211650376;1153.3541216918552;14959.775603365959;15028.173450460112;15055.473058442902;15249.618759530878;15312.770308445382;308510;308877;309299;311088;311329;51792;51857.74071129696;52192.73903630458;52385.73807131016;52524.73737631287;1301.4078594239597;1301.9544315948897;1323.2589749740175;1340.9262490562917;1348.892088632907;26992;28430.43139137247;28453.715462845106;31046.379072418877;31470.37059258848;46320.7683961578;46533.76733116313;46802.29796552986;46991;47091.29363059488;241686;244559;244953;244983;245069;41955.7902210487;42932.57067429286;43329;44287.55712442963;44394.334084989394;38880.6111938877;39306.803465983634;39489.2102157961;39743.403848942864;40278;32981;33662.495062573595;34041;34228.48657270093;34363.65636343705;40447.393289101274;41565.584344156174;41707.791461043715;42794.35808462813;45235.773821130686;37068.6293137076;37327.6267237335;37679;37862.24275514529;38127.61872381352;36279.274414511034;37392;37645.435318469696;37673.434898476;37771.43342849804;31394.843025784725;32245.355092897542;32285.192870178435;32376.514352284263;32575.837120814245 05:30:58 INFO - PROCESS | 25981 | |2;jquery.html;372.2331996088059;372.50828905844287;373.1771443966055;375.583102755941;382.9081020555068;15749.448769293078;16938.40715574955;17059.829401705978;17539.82460175398;17646.470605881812;10968;11780.352080635561;15801.60495987601;15948.76076858848;15950.122743249116;4738.573528382453;4976.452590215092;4980.327655766479;4991.825286114987;4992.301077849104;4868.099401610696;4949.777260023289;4993.550580447759;4994.725290109042;5152.381714194284;5094.694318340893;5296.576273898098;5345.518903298703;5446.455354464541;5477.123660214366;5240.240165176047;5256.106461901467;5259.053370393328;5537.390887002467;5980.0431930890845;5313.1764576490705;5355.0896347621;5359.517643412073;5359.973200133974;5362.705051222181;13107.737845243137;13110.737785244337;13159.14465559745;13787;14691.53084691533;2091.2262462888675;2113.1336152177532;2121.95756084879;2214.900329485161;2280;9016.819663606691;9532.999035101284;9630.3258771886;9640.276979226515;9860.506974651238;1751.036929688666;1764.214924358661;1872.447627949758;1881.4355693292096;1917.3768525229357;56598.03648793669;59037.50587435336;59681.10478342785;59782.402175978554;60166.69916650389;10290.948545257375;10312.381257124447;10314.896851031544;10336.379817210991;10395;13538.729225415436;13553.39009744564;13602;13621.318934053257;13629.863701363058;7373.188949215582;7441.888371674429;7640.885386719204;7693.422993275415;7714.6914123434435;7028.718851245892;7029.191642961125;7054.4003759681;7056.223815380304;7320.084989376328;4389.297712366006;4439.178751930903;4502.144592527409;4524.0951809637545;4525.162844873643;1870.1023508715894;1880.8025157358554;1900.429871038683;1902.8477721782224;1941.8640695151487;867.4968518259394;980.857775622545;1009.7172791618359;1016.6238491758097;1033.4367769565604;15720.024091228113;15815.446459373867;15928.203589820463;16035.438759643357;16159.838401616069;943.6225509796;954.465499320369;958.3531116496337;977.9657711980046;985.3584067726002;9257.120573545502;9524.333296669305;9525.809483810284;9656.813251626947;9669.951650241705;553321;555486;555572;556763;566297;72429.6378518104;73812.99999999892;76372.61813691007;76890.61554692191;77171.22828771753;1130.5760339872547;1163.7381589142544;1168.0830548019765;1185.8280549320473;1199.57415117632;15360.539183824503;15439.150846703538;15450;15559.611009724847;16010.759838602196;33771.81798637036;33790.831045844614;34659.4801077979;34738.82630586831;34988.30023399467;44195;44409.333859992774;44451.55548444474;45029.32456013097;45512.317315239634;7143.4999550031;7193.568385896863;7294.416446684147;7392.8891066635115;7399.630018499161;9013.684521041732;11033.889661103287;11107.38909359993;11128.054115400282;11329.206955513035;2718.384548550384;2845.0895713371524;5610.49505544503;9488.33581649278;9901.653442129491;9926.652567160114;9977.401355918668;10138.935411781657;10330.948345258226;10462.581496740046;9743.512824358895;10269.178465722875;10312.381257124596;10352.585896564053;10390.532426040696;7425.183229844821;7453.105627324756;7507;7509.699612015458;7529.698812047457;9829.164521015793;9829.557669905014;9932.950335248277;9966.053224943618;10009.54957026921 05:30:58 INFO - PROCESS | 25981 | |3;mootools.html;1447.9420823167077;1455.1850963460463;1591.3873158833853;1745.432734361333;1753.6229710612215;6820.556663816861;6930.653467326639;7714.267144621266;7947.1258161602245;7952.92047079529;7433.442491813109;7653.808654783619;7763.107242667095;7764.223577642247;7775.805604859881;2356.9511567352533;2397.9520409591796;2410.4696966667307;2411.3489357873364;2425.769551892576;2343.94140146496;2379.4884099918513;2386.7971222446113;2397.30478161333;2398.304491697406;2353.752855950126;2364.3498038039593;2392.605220138675;2409.771071748181;2413.1433341163897;2365.089440565395;2368.917087901924;2370.5140446208484;2378.92863214103;2416.275117464771;2373.596488596943;2374.964375534351;2382.3805810489225;2397.6643269942047;2402.4954759500524;7904.051513818321;7929.801754956115;7947.324477419426;8004.359651227946;8007.879881801778;4684.929726054078;4723.929141062887;4741.502142275046;4754.690945088558;4771.618270538349;3057.877684892602;3097.504399296102;3118.937621247562;3135.04381163745;3206.839658017113;1014.9644762433279;1022.4734261855151;1041.0890470838017;1052.5947510208548;1059.3855563772993;10754.838677419844;10759.30064545802;10853.457327133612;10875.78248435027;10886.29239099456;4223.767692776927;4300.80646370914;4375.78121093944;4412.933805992912;4421.115776844644;8814.515201663842;8939.284857211538;9048.41185322965;9062.410943288665;9073.727788166365;4912.803487860517;4928.383952005999;4928.457869634337;4967.130752118364;4972.378452693413;4327.242732521796;4438.889027774331;4464.084862603158;4498.3252512123445;4504.864854054384;3652.7990960497427;3673.9081522961606;3679.5216621839527;3702.7593206441493;3709.295233905549;1149.350616901448;1154.2266681323533;1155.3414553704476;1157.7337212441187;1157.774234024374;1034.4982683398546;1037.7768779712399;1050.8949105089582;1182.5920057580122;1334.652990222549;7426.925730742623;7599.582022988679;7603.2776886195725;7626.6186690665245;7682.462227644123;1108.4291589831244;1110.7389763405592;1124.876263611002;1126.7633796902742;1157.4675649201292;5810.564207684356;5863.589548731547;5971.402859713994;5991.400859913973;6021.217241758543;9209.677661281823;9450.291228157916;9689.515524223902;9751.463669498246;9765.072318129767;9357.90642093584;9515;9536.952315238519;9582.185514231229;9596.280278979104;7370.189279179286;7425.777226683208;7505;7555.24447555251;7644.847103057908;7397.03838501013;7451.3666338361845;7487.251274872469;7498.212687667717;7525.285097915689;8371.748847534584;8637.654493820177;8876.28989680811;8879.156480134636;8880.73357799267;8778.604962776819;8976.371653984159;9012.369134160546;9036.186743193144;9051.275897928019;6287.842803929939;6492.415682588589;6726.6972986216715;7067.752628657972;7236.34872861445;7581.696732130874;7619.4285428594185;7632.618369081412;7647.349975251944;7656.425768067528;6963.61700106499;7133.464990125865;7201.603911784902;7261.3101755333155;7308.269173082649;7220.0613920190035;7274.345308922222;7276.199618042117;7311.524750891175;7350.4854660175415;6748.932510675027;6833.077534532775;6863.965680171567;6876.243613202644;6881.277465866012;6279.340669229665;6338.429541341301;6382.425581697669;6389.840253993687;6391.456726178327;6074.119252708244;6114.052321890114;6121.755129794937;6146.631202127886;6184.381561843779 05:30:58 INFO - PROCESS | 25981 | |4;prototype.html;351.4219109564766;354.5090050280362;359.5739049226665;360.66818526955205;364.37145923282355;6276.843078923023;6288.6855657217075;6378.043293505971;6380.80857574273;6474.741010359592;6280.214973128359;6309.842253943653;6311.053341998702;6324.715387807548;6335.239771227459;4820.807167713305;4820.831270905519;4839.540243676845;4845.636577256702;4846.0792449434675;4827.58965487934;4842.491538388454;4844.346013288214;4844.87887802806;4852.272159176134;4624.213883639789;4700.553447422507;4725.385699859014;4727.645426593002;4790.616750659939;4703.176944034797;4710.034442939189;4711.717296962159;4718.787654555554;4719.764011799431;4091.6317531422314;4112.321466957948;4114.238865809834;4120.896977575555;4121.443605113302;5979.820605381846;6003.429674180946;6020.69896505173;6028.125921741367;6048.727807248684;5479.589030822664;5517.648176196817;5552.250446189753;5570.721463926788;5579.163125531162;6692.293465166352;6693.531452798306;6696.83257918556;6699.765508207238;6700.028495868072;4592.770361481913;4598.195315819718;4602.677812553123;4603.353071983623;4605.37827393301;6866.279040700704;6960.721571137148;7034.437245020386;7045.365917067488;7116.715331386738;4698.671093023524;4714.57568818808;4730.621550276039;4738.928916066262;4743.407074115736;4680.953190468052;4753;4755.690880092783;4759.024399997992;4776.331313616097;5499.202615620713;5567.3040869891265;5568.3318001839225;5571.052921003358;5572.219889215513;6658.4673226141795;6754.290799466084;6814.1482314710665;6851.2806155353965;6859;1639.049351376199;1668.7246604310396;1672.3979367427717;1674.67343867947;1677.790276215473;1108.534415545473;1120.1374941295157;1120.3278033180027;1123.9100871930225;1129.5989923577013;6251.124842521959;6296.937030629635;6303.212098487689;6311.368863113652;6312.6212427253595;6785.016172655036;6855.280195579492;6862.936244882051;6880.793576192722;6890.000949862242;6120.908186377208;6234.501239900797;6265.906011409833;6268.279147897959;6279.843003924847;3717.628237176261;3722.8696995605023;3738.7569807962395;3745.183585960807;3746.5691445484117;7086.043384143075;7121.750738724223;7125.821854453577;7161.785146445615;7162.068931038932;6930;7046.788596342118;7053.259407762213;7059;7077.469189810785;7228.421726261887;7307.817304567428;7308.817279568053;7320.487565870444;7322.414206863545;6955.408790252885;6987.580745155307;7032.085828842218;7034.437245020284;7051.294870512907;6832.555883867532;6919.135108111486;6925.3074692530345;6934.0985671864355;6935.514513983972;7271.890921636285;7283.380912622274;7284.235155308616;7284.745033923788;7286.162091359562;4721.763911804464;4764.094821983812;4768.594669452997;4788.473267940593;4789.61683065347;6838.281980391987;6986.196587392515;6986.476014298846;6992.825179370557;7009.404200643003;6769.356911093439;6779.389854913082;6800.6599670017295;6813.250542440229;6833.077534532775;6761.256261811295;6769.93230067693;6781.864362712817;6800.965995169992;6822.727090916308;6474.5791523550815;6623.105880706043;6639.170103737033;6639.970804525306;6643.136392268974;6778.7288508459105;6794.422474089758;6828.419584335188;6833.521653484208;6841.418479429304;6626;6660.666966651745;6662.800115996528;6676.76631317921;6677.565958212701 05:30:58 INFO - PROCESS | 25981 | |5;yui.html;762.9847403051938;773.2769860180734;828.7513745876239;846.3990566697648;873.4977388001901;13364.198148111109;13545.525906593271;13549.916006719463;13554.728905421885;13641.65895852603;12532.310722910237;12627.810582841264;12694.555690550833;12698.174618649782;12778.68053298668;763.7632333976458;784.4273680213419;788.8264581791997;790.5059337913804;791.3787676673812;797.5852556670528;804.8309854930471;806.1011971651595;806.5040000399771;808.0908977400425;835.9122292159327;836.2431999040878;837.5100566168799;838.1660248053196;838.8741688746707;827.8385714785619;827.8509868223747;830.4602008694367;830.8047608811925;831.8128421105264;609.3966972697042;610.5115907274163;611.2390074357453;614.1892701633845;614.5728718540616;12631.621051368473;12702.237865728086;12706.157607146912;12723.10938234324;12783.105182637219;11202.061618830183;11409.885901140966;11456.19806613529;11459.427028648533;11476.885231147666;9059.411138276057;9140.588673509708;9176.082391760838;9331.673391431335;9364.906350936471;3506.754527183098;3513.051476101464;3514.1390359361862;3535.611082780892;3538.43385058392;43042.569574304485;47730.761346193394;49070.99999999964;49414.25878611824;49509.50490495085;9885.901140988643;9900.207983361313;10104.141148002502;10226.437545935045;10309.53607087683;17789;17818.376356827448;17828.46514604564;17829.821701782817;17845.643087138185;7324.560526368435;7429;7638.961805191049;7799;7799.688012479551;4173.812178451977;4174.3947127666925;4202.831886724497;4219.852305169305;4232.36514522824;3204.7436205103536;3250.6911843375315;3265.134739294089;3270.035339574831;3271.084096452997;569.7265312649952;578.6296770067161;580.994190058094;597.202734349648;609.3784339973291;646.9482441404676;663.9900401493982;672.8082496488478;680.9591424514545;692.19705142036;7900.604969751489;8326.916730832614;8367.163283671705;8531.146885311418;8549.145085491526;648.8410339466766;654.4796886475264;683.641088428579;711.1040089487283;726.6584705188659;3848.5574158972076;3930.4890364252465;3937.448757173998;4039.6566291864933;4042.8584999524874;57198.14202786962;57275.71362143163;57622;58046.4195358041;58092.12861807076;45726.5427345729;52247.216291755656;52403;52664;57439;50892.491075089514;51543.48456515462;54633.1805022925;56137.438625614035;56522.71738641363;8484.533350665773;8810.471371717718;8876.28989680811;8879.934407871096;9014.684486042957;36571.63428365682;37082.44376334411;37148.44277335896;37219;38071;44737;44795;44936.55063449324;45230;45244.54755452535;10859.131269498263;10927.781444371227;10957.232993690364;11110.888891111308;11332;11202.38386888729;11205;11224.326540407601;11437.656870293904;11695;10773.515191816543;10882.673519794418;11171.832422513506;11340.09279257674;11462.312261264016;11093.22669332667;11133.665990020312;11286.604968826052;11421.200515963803;11821.704457388634;10419.374837509773;10599.417032063311;10614.575416983234;10844.240903136704;11312.20814542974;8924.330675199515;9435.481048542397;9605.327627066317;9662.227021838376;9790.559424826042;8215.178482151738;8423.824277639658;8552.700655477029;9090.999830317349;9651.03653008988 05:30:58 INFO - PROCESS | 25981 | __end_tp_report 05:30:58 INFO - PROCESS | 25981 | __start_cc_report 05:30:58 INFO - PROCESS | 25981 | _x_x_mozilla_cycle_collect,317 05:30:58 INFO - PROCESS | 25981 | __end_cc_report 05:30:58 INFO - PROCESS | 25981 | __startTimestamp1452778258683__endTimestamp 05:30:58 INFO - PROCESS | 25981 | 05:30:58 INFO - PROCESS | 25981 | ------- Summary: start ------- 05:30:58 INFO - PROCESS | 25981 | Number of tests: 6 05:30:58 INFO - PROCESS | 25981 | 05:30:58 INFO - PROCESS | 25981 | [#0] dojo.html Cycles:165 Average:5333.46 Median:5509.17 stddev:574.93 (10.4%) stddev-sans-first:552.43 05:30:58 INFO - PROCESS | 25981 | Values: 3226.4 3227.9 3252.4 3272.5 3273.2 5241.8 5269.4 5342.9 5349.4 5353.8 5240.8 5270.2 5371.9 5407.4 5412.1 4801.7 4813.1 4828.2 4872.5 5008.7 4954.7 4973.1 4978.5 5030.4 5051.2 4783.1 4849.4 4851.8 4958.9 4983.0 4877.3 4895.5 4905.0 4915.1 4961.9 4715.8 4896.6 4897.5 4907.1 4979.2 5173.9 5195.5 5232.6 5242.5 5252.8 5813.8 5831.5 5835.3 5835.4 5837.4 5591.6 5723.7 5854.2 5856.9 5872.9 5328.0 5330.8 5336.7 5336.8 5337.9 5731.3 5767.6 5787.6 5799.3 5821.2 5573.4 5584.6 5588.4 5636.1 5740.0 5724.4 5734.9 5774.3 5774.9 5780.0 5739.3 5748.5 5749.2 5750.2 5752.9 5501.0 5583.1 5600.8 5604.7 5744.3 4437.0 4441.6 4493.2 4546.9 4590.8 3963.0 3965.3 3971.0 3978.6 4012.0 5223.3 5336.4 5353.0 5355.7 5361.0 5716.7 5737.9 5754.3 5756.1 5765.2 5455.5 5456.5 5457.6 5464.0 5471.8 4923.4 4931.2 4977.6 4980.1 5013.7 5750.7 5810.8 5865.1 5871.7 5994.4 5734.0 5759.5 5800.2 5841.6 5915.9 5883.4 5910.7 5962.1 5962.9 5970.9 5638.4 5640.3 5641.2 5654.1 5718.3 5639.7 5712.9 5713.2 5716.9 5719.3 5548.5 5575.2 5642.9 5739.8 5782.0 5495.6 5601.0 5602.7 5608.2 5618.9 5387.3 5492.5 5498.2 5504.9 5509.2 5520.1 5627.7 5755.7 5759.3 5805.1 5508.4 5520.3 5522.8 5525.5 5537.8 05:30:58 INFO - PROCESS | 25981 | 05:30:58 INFO - PROCESS | 25981 | [#1] ext.html Cycles:180 Average:43928.04 Median:36710.45 stddev:68032.12 (185.3%) stddev-sans-first:68144.90 05:30:58 INFO - PROCESS | 25981 | Values: 521.8 538.9 550.2 570.3 623.6 35038.0 35509.3 35552.6 35607.3 35689.1 36007.6 36280.1 36281.6 36459.6 36645.8 8205.7 8432.7 8435.6 8442.7 8447.5 8176.8 8357.9 8455.7 8462.4 8484.1 8374.8 8427.0 8445.7 8483.1 8498.6 8408.1 8434.2 8447.7 8450.5 8454.8 8283.3 8432.5 8439.3 8458.8 8485.7 36203.3 36677.0 36679.4 36741.4 36867.3 3180.6 3196.6 3227.9 3379.5 3462.3 29202.0 29343.0 29613.9 29631.4 30622.5 3742.3 3807.0 3903.1 3916.6 3960.6 220731.0 220916.0 221274.0 221606.0 223326.0 53083.0 55015.4 55580.7 55636.4 55652.4 64789.0 65597.7 65799.7 65993.0 66312.7 15570.1 15653.4 15721.0 15763.6 15768.9 12015.8 12016.9 12077.2 12093.3 12099.3 19354.8 19504.8 19587.7 20121.8 20489.9 8043.0 8076.6 8145.6 8174.0 8257.9 907.0 936.8 967.5 1034.4 1047.9 28018.2 28333.9 28609.3 28684.3 28788.7 1056.5 1065.0 1067.6 1079.8 1153.4 14959.8 15028.2 15055.5 15249.6 15312.8 308510.0 308877.0 309299.0 311088.0 311329.0 51792.0 51857.7 52192.7 52385.7 52524.7 1301.4 1302.0 1323.3 1340.9 1348.9 26992.0 28430.4 28453.7 31046.4 31470.4 46320.8 46533.8 46802.3 46991.0 47091.3 241686.0 244559.0 244953.0 244983.0 245069.0 41955.8 42932.6 43329.0 44287.6 44394.3 38880.6 39306.8 39489.2 39743.4 40278.0 32981.0 33662.5 34041.0 34228.5 34363.7 40447.4 41565.6 41707.8 42794.4 45235.8 37068.6 37327.6 37679.0 37862.2 38127.6 36279.3 37392.0 37645.4 37673.4 37771.4 31394.8 32245.4 32285.2 32376.5 32575.8 05:30:58 INFO - PROCESS | 25981 | 05:30:58 INFO - PROCESS | 25981 | [#2] jquery.html Cycles:180 Average:27961.46 Median:25018.74 stddev:91162.74 (364.4%) stddev-sans-first:91394.94 05:30:58 INFO - PROCESS | 25981 | Values: 372.2 372.5 373.2 375.6 382.9 15749.4 16938.4 17059.8 17539.8 17646.5 10968.0 11780.4 15801.6 15948.8 15950.1 4738.6 4976.5 4980.3 4991.8 4992.3 4868.1 4949.8 4993.6 4994.7 5152.4 5094.7 5296.6 5345.5 5446.5 5477.1 5240.2 5256.1 5259.1 5537.4 5980.0 5313.2 5355.1 5359.5 5360.0 5362.7 13107.7 13110.7 13159.1 13787.0 14691.5 2091.2 2113.1 2122.0 2214.9 2280.0 9016.8 9533.0 9630.3 9640.3 9860.5 1751.0 1764.2 1872.4 1881.4 1917.4 56598.0 59037.5 59681.1 59782.4 60166.7 10290.9 10312.4 10314.9 10336.4 10395.0 13538.7 13553.4 13602.0 13621.3 13629.9 7373.2 7441.9 7640.9 7693.4 7714.7 7028.7 7029.2 7054.4 7056.2 7320.1 4389.3 4439.2 4502.1 4524.1 4525.2 1870.1 1880.8 1900.4 1902.8 1941.9 867.5 980.9 1009.7 1016.6 1033.4 15720.0 15815.4 15928.2 16035.4 16159.8 943.6 954.5 958.4 978.0 985.4 9257.1 9524.3 9525.8 9656.8 9670.0 553321.0 555486.0 555572.0 556763.0 566297.0 72429.6 73813.0 76372.6 76890.6 77171.2 1130.6 1163.7 1168.1 1185.8 1199.6 15360.5 15439.2 15450.0 15559.6 16010.8 33771.8 33790.8 34659.5 34738.8 34988.3 44195.0 44409.3 44451.6 45029.3 45512.3 7143.5 7193.6 7294.4 7392.9 7399.6 9013.7 11033.9 11107.4 11128.1 11329.2 2718.4 2845.1 5610.5 9488.3 9901.7 9926.7 9977.4 10138.9 10330.9 10462.6 9743.5 10269.2 10312.4 10352.6 10390.5 7425.2 7453.1 7507.0 7509.7 7529.7 9829.2 9829.6 9933.0 9966.1 10009.5 05:30:58 INFO - PROCESS | 25981 | 05:30:58 INFO - PROCESS | 25981 | [#3] mootools.html Cycles:180 Average:5545.52 Median:6094.09 stddev:2853.08 (46.8%) stddev-sans-first:2844.46 05:30:58 INFO - PROCESS | 25981 | Values: 1447.9 1455.2 1591.4 1745.4 1753.6 6820.6 6930.7 7714.3 7947.1 7952.9 7433.4 7653.8 7763.1 7764.2 7775.8 2357.0 2398.0 2410.5 2411.3 2425.8 2343.9 2379.5 2386.8 2397.3 2398.3 2353.8 2364.3 2392.6 2409.8 2413.1 2365.1 2368.9 2370.5 2378.9 2416.3 2373.6 2375.0 2382.4 2397.7 2402.5 7904.1 7929.8 7947.3 8004.4 8007.9 4684.9 4723.9 4741.5 4754.7 4771.6 3057.9 3097.5 3118.9 3135.0 3206.8 1015.0 1022.5 1041.1 1052.6 1059.4 10754.8 10759.3 10853.5 10875.8 10886.3 4223.8 4300.8 4375.8 4412.9 4421.1 8814.5 8939.3 9048.4 9062.4 9073.7 4912.8 4928.4 4928.5 4967.1 4972.4 4327.2 4438.9 4464.1 4498.3 4504.9 3652.8 3673.9 3679.5 3702.8 3709.3 1149.4 1154.2 1155.3 1157.7 1157.8 1034.5 1037.8 1050.9 1182.6 1334.7 7426.9 7599.6 7603.3 7626.6 7682.5 1108.4 1110.7 1124.9 1126.8 1157.5 5810.6 5863.6 5971.4 5991.4 6021.2 9209.7 9450.3 9689.5 9751.5 9765.1 9357.9 9515.0 9537.0 9582.2 9596.3 7370.2 7425.8 7505.0 7555.2 7644.8 7397.0 7451.4 7487.3 7498.2 7525.3 8371.7 8637.7 8876.3 8879.2 8880.7 8778.6 8976.4 9012.4 9036.2 9051.3 6287.8 6492.4 6726.7 7067.8 7236.3 7581.7 7619.4 7632.6 7647.3 7656.4 6963.6 7133.5 7201.6 7261.3 7308.3 7220.1 7274.3 7276.2 7311.5 7350.5 6748.9 6833.1 6864.0 6876.2 6881.3 6279.3 6338.4 6382.4 6389.8 6391.5 6074.1 6114.1 6121.8 6146.6 6184.4 05:30:58 INFO - PROCESS | 25981 | 05:30:58 INFO - PROCESS | 25981 | [#4] prototype.html Cycles:180 Average:5607.87 Median:6306.53 stddev:1713.59 (27.2%) stddev-sans-first:1672.37 05:30:58 INFO - PROCESS | 25981 | Values: 351.4 354.5 359.6 360.7 364.4 6276.8 6288.7 6378.0 6380.8 6474.7 6280.2 6309.8 6311.1 6324.7 6335.2 4820.8 4820.8 4839.5 4845.6 4846.1 4827.6 4842.5 4844.3 4844.9 4852.3 4624.2 4700.6 4725.4 4727.6 4790.6 4703.2 4710.0 4711.7 4718.8 4719.8 4091.6 4112.3 4114.2 4120.9 4121.4 5979.8 6003.4 6020.7 6028.1 6048.7 5479.6 5517.6 5552.3 5570.7 5579.2 6692.3 6693.5 6696.8 6699.8 6700.0 4592.8 4598.2 4602.7 4603.4 4605.4 6866.3 6960.7 7034.4 7045.4 7116.7 4698.7 4714.6 4730.6 4738.9 4743.4 4681.0 4753.0 4755.7 4759.0 4776.3 5499.2 5567.3 5568.3 5571.1 5572.2 6658.5 6754.3 6814.1 6851.3 6859.0 1639.0 1668.7 1672.4 1674.7 1677.8 1108.5 1120.1 1120.3 1123.9 1129.6 6251.1 6296.9 6303.2 6311.4 6312.6 6785.0 6855.3 6862.9 6880.8 6890.0 6120.9 6234.5 6265.9 6268.3 6279.8 3717.6 3722.9 3738.8 3745.2 3746.6 7086.0 7121.8 7125.8 7161.8 7162.1 6930.0 7046.8 7053.3 7059.0 7077.5 7228.4 7307.8 7308.8 7320.5 7322.4 6955.4 6987.6 7032.1 7034.4 7051.3 6832.6 6919.1 6925.3 6934.1 6935.5 7271.9 7283.4 7284.2 7284.7 7286.2 4721.8 4764.1 4768.6 4788.5 4789.6 6838.3 6986.2 6986.5 6992.8 7009.4 6769.4 6779.4 6800.7 6813.3 6833.1 6761.3 6769.9 6781.9 6801.0 6822.7 6474.6 6623.1 6639.2 6640.0 6643.1 6778.7 6794.4 6828.4 6833.5 6841.4 6626.0 6660.7 6662.8 6676.8 6677.6 05:30:58 INFO - PROCESS | 25981 | 05:30:58 INFO - PROCESS | 25981 | [#5] yui.html Cycles:180 Average:13924.55 Median:51895.35 stddev:16608.34 (32.0%) stddev-sans-first:16625.52 05:30:58 INFO - PROCESS | 25981 | Values: 763.0 773.3 828.8 846.4 873.5 13364.2 13545.5 13549.9 13554.7 13641.7 12532.3 12627.8 12694.6 12698.2 12778.7 763.8 784.4 788.8 790.5 791.4 797.6 804.8 806.1 806.5 808.1 835.9 836.2 837.5 838.2 838.9 827.8 827.9 830.5 830.8 831.8 609.4 610.5 611.2 614.2 614.6 12631.6 12702.2 12706.2 12723.1 12783.1 11202.1 11409.9 11456.2 11459.4 11476.9 9059.4 9140.6 9176.1 9331.7 9364.9 3506.8 3513.1 3514.1 3535.6 3538.4 43042.6 47730.8 49071.0 49414.3 49509.5 9885.9 9900.2 10104.1 10226.4 10309.5 17789.0 17818.4 17828.5 17829.8 17845.6 7324.6 7429.0 7639.0 7799.0 7799.7 4173.8 4174.4 4202.8 4219.9 4232.4 3204.7 3250.7 3265.1 3270.0 3271.1 569.7 578.6 581.0 597.2 609.4 646.9 664.0 672.8 681.0 692.2 7900.6 8326.9 8367.2 8531.1 8549.1 648.8 654.5 683.6 711.1 726.7 3848.6 3930.5 3937.4 4039.7 4042.9 57198.1 57275.7 57622.0 58046.4 58092.1 45726.5 52247.2 52403.0 52664.0 57439.0 50892.5 51543.5 54633.2 56137.4 56522.7 8484.5 8810.5 8876.3 8879.9 9014.7 36571.6 37082.4 37148.4 37219.0 38071.0 44737.0 44795.0 44936.6 45230.0 45244.5 10859.1 10927.8 10957.2 11110.9 11332.0 11202.4 11205.0 11224.3 11437.7 11695.0 10773.5 10882.7 11171.8 11340.1 11462.3 11093.2 11133.7 11286.6 11421.2 11821.7 10419.4 10599.4 10614.6 10844.2 11312.2 8924.3 9435.5 9605.3 9662.2 9790.6 8215.2 8423.8 8552.7 9091.0 9651.0 05:30:58 INFO - PROCESS | 25981 | -------- Summary: end -------- 05:30:58 INFO - PROCESS | 25981 | 05:30:59 INFO - TEST-INFO | 25981: exit 0 05:30:59 INFO - TEST-OK | dromaeo_css | took 1110329ms 05:30:59 INFO - TEST-START | kraken 05:30:59 INFO - operating with platform_type : linux_ 05:30:59 INFO - Initialising browser for kraken test... 05:30:59 INFO - TEST-INFO | started process 26223 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfVtACP/profile http://localhost:55789/getInfo.html) 05:31:02 INFO - PROCESS | 26223 | 05:31:02 INFO - PROCESS | 26223 | (process:26295): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:31:03 INFO - PROCESS | 26223 | __metrics Screen width/height:1600/1200 05:31:03 INFO - PROCESS | 26223 | colorDepth:24 05:31:03 INFO - PROCESS | 26223 | Browser inner width/height: 1024/697 05:31:03 INFO - PROCESS | 26223 | __metrics 05:31:03 INFO - PROCESS | 26223 | 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:04 INFO - TEST-INFO | 26223: exit 0 05:31:04 INFO - Browser initialized. 05:31:04 INFO - Running cycle 1/1 for kraken test... 05:31:04 INFO - TEST-INFO | started process 26344 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfVtACP/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:05 INFO - PROCESS | 26344 | 05:31:05 INFO - PROCESS | 26344 | (process:26404): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:31:16 INFO - PROCESS | 26344 | RSS: Main: 150794240 05:31:16 INFO - PROCESS | 26344 | 05:31:18 INFO - PROCESS | 26344 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55789/tests/kraken/driver.html?testName=audio-beat-detection) 05:31:19 INFO - PROCESS | 26344 | RSS: Main: 151015424 05:31:19 INFO - PROCESS | 26344 | 05:31:22 INFO - PROCESS | 26344 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55789/tests/kraken/driver.html?testName=audio-dft) 05:31:22 INFO - PROCESS | 26344 | RSS: Main: 155381760 05:31:22 INFO - PROCESS | 26344 | 05:31:25 INFO - PROCESS | 26344 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55789/tests/kraken/driver.html?testName=audio-fft) 05:31:26 INFO - PROCESS | 26344 | RSS: Main: 148688896 05:31:26 INFO - PROCESS | 26344 | 05:31:28 INFO - PROCESS | 26344 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55789/tests/kraken/driver.html?testName=audio-oscillator) 05:31:28 INFO - PROCESS | 26344 | RSS: Main: 148533248 05:31:28 INFO - PROCESS | 26344 | 05:31:31 INFO - PROCESS | 26344 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55789/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:31:31 INFO - PROCESS | 26344 | RSS: Main: 149147648 05:31:31 INFO - PROCESS | 26344 | 05:31:34 INFO - PROCESS | 26344 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55789/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:35 INFO - PROCESS | 26344 | RSS: Main: 150380544 05:31:35 INFO - PROCESS | 26344 | 05:31:38 INFO - PROCESS | 26344 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55789/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:39 INFO - PROCESS | 26344 | RSS: Main: 150138880 05:31:39 INFO - PROCESS | 26344 | 05:31:42 INFO - PROCESS | 26344 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55789/tests/kraken/driver.html?testName=json-parse-financial) 05:31:42 INFO - PROCESS | 26344 | RSS: Main: 148574208 05:31:42 INFO - PROCESS | 26344 | 05:31:44 INFO - PROCESS | 26344 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55789/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:44 INFO - PROCESS | 26344 | RSS: Main: 149897216 05:31:44 INFO - PROCESS | 26344 | 05:31:46 INFO - PROCESS | 26344 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55789/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:47 INFO - PROCESS | 26344 | RSS: Main: 150364160 05:31:47 INFO - PROCESS | 26344 | 05:31:49 INFO - PROCESS | 26344 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55789/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:49 INFO - PROCESS | 26344 | RSS: Main: 150405120 05:31:49 INFO - PROCESS | 26344 | 05:31:52 INFO - PROCESS | 26344 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55789/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:53 INFO - PROCESS | 26344 | RSS: Main: 151097344 05:31:53 INFO - PROCESS | 26344 | 05:31:55 INFO - PROCESS | 26344 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55789/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:56 INFO - PROCESS | 26344 | RSS: Main: 150298624 05:31:56 INFO - PROCESS | 26344 | 05:31:57 INFO - PROCESS | 26344 | Cycle 1(1): loaded http://localhost:55789/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55789/tests/kraken/driver.html?testName=ai-astar) 05:31:58 INFO - PROCESS | 26344 | RSS: Main: 150880256 05:31:58 INFO - PROCESS | 26344 | 05:31:58 INFO - PROCESS | 26344 | __start_tp_report 05:31:58 INFO - PROCESS | 26344 | _x_x_mozilla_page_load 05:31:58 INFO - PROCESS | 26344 | _x_x_mozilla_page_load_details 05:31:58 INFO - PROCESS | 26344 | |i|pagename|runs| 05:31:58 INFO - PROCESS | 26344 | |0;ai-astar;111;105;112;109;113;122;112;111;112;113 05:31:58 INFO - PROCESS | 26344 | |1;audio-beat-detection;150;127;150;161;128;147;153;129;160;130 05:31:58 INFO - PROCESS | 26344 | |2;audio-dft;164;163;163;162;163;163;161;164;171;161 05:31:58 INFO - PROCESS | 26344 | |3;audio-fft;73;73;73;75;72;129;71;72;72;73 05:31:58 INFO - PROCESS | 26344 | |4;audio-oscillator;96;95;146;95;96;96;140;97;96;136 05:31:58 INFO - PROCESS | 26344 | |5;imaging-gaussian-blur;110;111;110;111;110;111;110;110;111;109 05:31:58 INFO - PROCESS | 26344 | |6;imaging-darkroom;147;148;147;149;146;146;147;147;147;147 05:31:58 INFO - PROCESS | 26344 | |7;imaging-desaturate;96;97;96;96;99;96;96;97;96;96 05:31:58 INFO - PROCESS | 26344 | |8;json-parse-financial;58;62;59;57;61;59;58;58;58;60 05:31:58 INFO - PROCESS | 26344 | |9;json-stringify-tinderbox;68;69;68;68;68;68;68;69;68;68 05:31:58 INFO - PROCESS | 26344 | |10;stanford-crypto-aes;89;84;90;91;84;83;84;84;91;83 05:31:58 INFO - PROCESS | 26344 | |11;stanford-crypto-ccm;121;117;120;118;118;125;131;114;116;116 05:31:58 INFO - PROCESS | 26344 | |12;stanford-crypto-pbkdf2;142;143;144;143;146;141;152;160;140;142 05:31:58 INFO - PROCESS | 26344 | |13;stanford-crypto-sha256-iterative;66;67;66;66;68;67;67;66;67;66 05:31:58 INFO - PROCESS | 26344 | __end_tp_report 05:31:58 INFO - PROCESS | 26344 | __start_cc_report 05:31:58 INFO - PROCESS | 26344 | _x_x_mozilla_cycle_collect,760 05:31:58 INFO - PROCESS | 26344 | __end_cc_report 05:31:58 INFO - PROCESS | 26344 | __startTimestamp1452778318083__endTimestamp 05:31:58 INFO - PROCESS | 26344 | 05:31:58 INFO - PROCESS | 26344 | ------- Summary: start ------- 05:31:58 INFO - PROCESS | 26344 | Number of tests: 14 05:31:58 INFO - PROCESS | 26344 | 05:31:58 INFO - PROCESS | 26344 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:4.24 (3.8%) stddev-sans-first:4.48 05:31:58 INFO - PROCESS | 26344 | Values: 111.0 105.0 112.0 109.0 113.0 122.0 112.0 111.0 112.0 113.0 05:31:58 INFO - PROCESS | 26344 | 05:31:58 INFO - PROCESS | 26344 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:150.00 stddev:13.62 (9.1%) stddev-sans-first:14.25 05:31:58 INFO - PROCESS | 26344 | Values: 150.0 127.0 150.0 161.0 128.0 147.0 153.0 129.0 160.0 130.0 05:31:58 INFO - PROCESS | 26344 | 05:31:58 INFO - PROCESS | 26344 | [#2] audio-dft Cycles:10 Average:163.50 Median:163.00 stddev:2.84 (1.7%) stddev-sans-first:3.00 05:31:58 INFO - PROCESS | 26344 | Values: 164.0 163.0 163.0 162.0 163.0 163.0 161.0 164.0 171.0 161.0 05:31:58 INFO - PROCESS | 26344 | 05:31:58 INFO - PROCESS | 26344 | [#3] audio-fft Cycles:10 Average:78.30 Median:73.00 stddev:17.85 (24.4%) stddev-sans-first:18.82 05:31:58 INFO - PROCESS | 26344 | Values: 73.0 73.0 73.0 75.0 72.0 129.0 71.0 72.0 72.0 73.0 05:31:58 INFO - PROCESS | 26344 | 05:31:58 INFO - PROCESS | 26344 | [#4] audio-oscillator Cycles:10 Average:109.30 Median:96.00 stddev:21.78 (22.7%) stddev-sans-first:22.57 05:31:58 INFO - PROCESS | 26344 | Values: 96.0 95.0 146.0 95.0 96.0 96.0 140.0 97.0 96.0 136.0 05:31:58 INFO - PROCESS | 26344 | 05:31:58 INFO - PROCESS | 26344 | [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 05:31:58 INFO - PROCESS | 26344 | Values: 110.0 111.0 110.0 111.0 110.0 111.0 110.0 110.0 111.0 109.0 05:31:58 INFO - PROCESS | 26344 | 05:31:58 INFO - PROCESS | 26344 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 05:31:58 INFO - PROCESS | 26344 | Values: 147.0 148.0 147.0 149.0 146.0 146.0 147.0 147.0 147.0 147.0 05:31:58 INFO - PROCESS | 26344 | 05:31:58 INFO - PROCESS | 26344 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 05:31:58 INFO - PROCESS | 26344 | Values: 96.0 97.0 96.0 96.0 99.0 96.0 96.0 97.0 96.0 96.0 05:31:58 INFO - PROCESS | 26344 | 05:31:58 INFO - PROCESS | 26344 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.00 stddev:1.56 (2.6%) stddev-sans-first:1.62 05:31:58 INFO - PROCESS | 26344 | Values: 58.0 62.0 59.0 57.0 61.0 59.0 58.0 58.0 58.0 60.0 05:31:58 INFO - PROCESS | 26344 | 05:31:58 INFO - PROCESS | 26344 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 05:31:58 INFO - PROCESS | 26344 | Values: 68.0 69.0 68.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 05:31:58 INFO - PROCESS | 26344 | 05:31:58 INFO - PROCESS | 26344 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.50 stddev:3.47 (4.0%) stddev-sans-first:3.54 05:31:58 INFO - PROCESS | 26344 | Values: 89.0 84.0 90.0 91.0 84.0 83.0 84.0 84.0 91.0 83.0 05:31:58 INFO - PROCESS | 26344 | 05:31:58 INFO - PROCESS | 26344 | [#11] stanford-crypto-ccm Cycles:10 Average:119.60 Median:119.00 stddev:5.06 (4.3%) stddev-sans-first:5.34 05:31:58 INFO - PROCESS | 26344 | Values: 121.0 117.0 120.0 118.0 118.0 125.0 131.0 114.0 116.0 116.0 05:31:58 INFO - PROCESS | 26344 | 05:31:58 INFO - PROCESS | 26344 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.30 Median:143.50 stddev:6.17 (4.3%) stddev-sans-first:6.42 05:31:58 INFO - PROCESS | 26344 | Values: 142.0 143.0 144.0 143.0 146.0 141.0 152.0 160.0 140.0 142.0 05:31:58 INFO - PROCESS | 26344 | 05:31:58 INFO - PROCESS | 26344 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 05:31:58 INFO - PROCESS | 26344 | Values: 66.0 67.0 66.0 66.0 68.0 67.0 67.0 66.0 67.0 66.0 05:31:58 INFO - PROCESS | 26344 | -------- Summary: end -------- 05:31:58 INFO - PROCESS | 26344 | 05:31:58 INFO - TEST-INFO | 26344: exit 0 05:31:58 INFO - TEST-OK | kraken | took 59663ms 05:31:58 INFO - TEST-START | v8_7 05:31:58 INFO - operating with platform_type : linux_ 05:31:58 INFO - Initialising browser for v8_7 test... 05:31:58 INFO - TEST-INFO | started process 26632 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjjqL0m/profile http://localhost:55789/getInfo.html) 05:32:02 INFO - PROCESS | 26632 | 05:32:02 INFO - PROCESS | 26632 | (process:26706): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:32:03 INFO - PROCESS | 26632 | __metrics Screen width/height:1600/1200 05:32:03 INFO - PROCESS | 26632 | colorDepth:24 05:32:03 INFO - PROCESS | 26632 | Browser inner width/height: 1024/697 05:32:03 INFO - PROCESS | 26632 | __metrics 05:32:03 INFO - PROCESS | 26632 | 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:04 INFO - TEST-INFO | 26632: exit 0 05:32:04 INFO - Browser initialized. 05:32:04 INFO - Running cycle 1/1 for v8_7 test... 05:32:04 INFO - TEST-INFO | started process 26755 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjjqL0m/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:05 INFO - PROCESS | 26755 | 05:32:05 INFO - PROCESS | 26755 | (process:26814): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:32:16 INFO - PROCESS | 26755 | RSS: Main: 150732800 05:32:16 INFO - PROCESS | 26755 | 05:32:38 INFO - PROCESS | 26755 | Cycle 1(1): loaded http://localhost:55789/tests/v8_7/run.html (next: http://localhost:55789/tests/v8_7/run.html) 05:32:38 INFO - PROCESS | 26755 | RSS: Main: 146612224 05:32:38 INFO - PROCESS | 26755 | 05:32:38 INFO - PROCESS | 26755 | __start_tp_report 05:32:38 INFO - PROCESS | 26755 | _x_x_mozilla_page_load 05:32:38 INFO - PROCESS | 26755 | _x_x_mozilla_page_load_details 05:32:38 INFO - PROCESS | 26755 | |i|pagename|runs| 05:32:38 INFO - PROCESS | 26755 | |0;Richards;171.6148961729878 05:32:38 INFO - PROCESS | 26755 | |1;DeltaBlue;187.4062968515742 05:32:38 INFO - PROCESS | 26755 | |2;Encrypt;280.8988764044944 05:32:38 INFO - PROCESS | 26755 | |3;Decrypt;5175.257731958763 05:32:38 INFO - PROCESS | 26755 | |4;RayTrace;1067.2358591248667 05:32:38 INFO - PROCESS | 26755 | |5;Earley;700.2801120448179 05:32:38 INFO - PROCESS | 26755 | |6;Boyer;12243.90243902439 05:32:38 INFO - PROCESS | 26755 | |7;RegExp;41428.57142857143 05:32:38 INFO - PROCESS | 26755 | |8;Splay;564.3340857787811 05:32:38 INFO - PROCESS | 26755 | |9;NavierStokes;4840.579710144928 05:32:38 INFO - PROCESS | 26755 | __end_tp_report 05:32:38 INFO - PROCESS | 26755 | __startTimestamp1452778358761__endTimestamp 05:32:38 INFO - PROCESS | 26755 | 05:32:38 INFO - PROCESS | 26755 | ------- Summary: start ------- 05:32:38 INFO - PROCESS | 26755 | Number of tests: 10 05:32:38 INFO - PROCESS | 26755 | 05:32:38 INFO - PROCESS | 26755 | [#0] Richards Cycles:1 Average:171.61 Median:171.61 stddev:0.00 (0.0%) 05:32:38 INFO - PROCESS | 26755 | Values: 171.6 05:32:38 INFO - PROCESS | 26755 | 05:32:38 INFO - PROCESS | 26755 | [#1] DeltaBlue Cycles:1 Average:187.41 Median:187.41 stddev:0.00 (0.0%) 05:32:38 INFO - PROCESS | 26755 | Values: 187.4 05:32:38 INFO - PROCESS | 26755 | 05:32:38 INFO - PROCESS | 26755 | [#2] Encrypt Cycles:1 Average:280.90 Median:280.90 stddev:0.00 (0.0%) 05:32:38 INFO - PROCESS | 26755 | Values: 280.9 05:32:38 INFO - PROCESS | 26755 | 05:32:38 INFO - PROCESS | 26755 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 05:32:38 INFO - PROCESS | 26755 | Values: 5175.3 05:32:38 INFO - PROCESS | 26755 | 05:32:38 INFO - PROCESS | 26755 | [#4] RayTrace Cycles:1 Average:1067.24 Median:1067.24 stddev:0.00 (0.0%) 05:32:38 INFO - PROCESS | 26755 | Values: 1067.2 05:32:38 INFO - PROCESS | 26755 | 05:32:38 INFO - PROCESS | 26755 | [#5] Earley Cycles:1 Average:700.28 Median:700.28 stddev:0.00 (0.0%) 05:32:38 INFO - PROCESS | 26755 | Values: 700.3 05:32:38 INFO - PROCESS | 26755 | 05:32:38 INFO - PROCESS | 26755 | [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 05:32:38 INFO - PROCESS | 26755 | Values: 12243.9 05:32:38 INFO - PROCESS | 26755 | 05:32:38 INFO - PROCESS | 26755 | [#7] RegExp Cycles:1 Average:41428.57 Median:41428.57 stddev:0.00 (0.0%) 05:32:38 INFO - PROCESS | 26755 | Values: 41428.6 05:32:38 INFO - PROCESS | 26755 | 05:32:38 INFO - PROCESS | 26755 | [#8] Splay Cycles:1 Average:564.33 Median:564.33 stddev:0.00 (0.0%) 05:32:38 INFO - PROCESS | 26755 | Values: 564.3 05:32:38 INFO - PROCESS | 26755 | 05:32:38 INFO - PROCESS | 26755 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 05:32:38 INFO - PROCESS | 26755 | Values: 4840.6 05:32:38 INFO - PROCESS | 26755 | -------- Summary: end -------- 05:32:38 INFO - PROCESS | 26755 | 05:32:39 INFO - TEST-INFO | 26755: exit 0 05:32:39 INFO - TEST-OK | v8_7 | took 40688ms 05:32:39 INFO - SUITE-END | took 1210s 05:32:39 INFO - Completed test suite (00:20:10) 05:32:39 INFO - Working with test: dromaeo_css 05:32:39 INFO - Generating results file: dromaeo_css 05:32:39 INFO - Working with test: kraken 05:32:39 INFO - Generating results file: kraken 05:32:39 INFO - javascript benchmark 05:32:39 INFO - Working with test: v8_7 05:32:39 INFO - Generating results file: v8_7 05:32:39 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:32:39 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 05:32:39 INFO - process_Request line: dromaeo_css 6961.12 graph.html#tests=[[72,64,43]] 05:32:39 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:32:39 INFO - process_Request line: kraken 1505.50 graph.html#tests=[[232,64,43]] 05:32:39 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:32:39 INFO - process_Request line: v8_7 20492.87 graph.html#tests=[[230,64,43]] 05:32:39 INFO - RETURN: dromaeo_css: 6961.12 05:32:39 INFO - RETURN: kraken: 1505.50 05:32:39 INFO - RETURN: v8_7: 20492.87 05:32:39 INFO - javascript benchmark 05:32:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3226.435373809583, 3227.9193020174494, 3252.4308246056935, 3272.476403775396, 3273.1980664737143, 5241.790328386869, 5269.446708095643, 5342.866428339294, 5349.438308977555, 5353.839384818457, 5240.764165612547, 5270.156774916014, 5371.892562148755, 5407.3781515125775, 5412.134058550623, 4801.73590452525, 4813.109574728669, 4828.155072862252, 4872.488388719186, 5008.724520151391, 4954.653174277802, 4973.0551195272965, 4978.502149785028, 5030.421501527317, 5051.166557518023, 4783.139034973703, 4849.418069831625, 4851.830185943475, 4958.9008219835405, 4982.950170498285, 4877.317175595419, 4895.510448955111, 4904.975475122637, 4915.1398505261795, 4961.875953101166, 4715.764211789431, 4896.559309662148, 4897.4857639948, 4907.067657145131, 4979.153543897546, 5173.948260517384, 5195.480451954812, 5232.581393488512, 5242.5281724644965, 5252.816151434681, 5813.82558523245, 5831.475167234969, 5835.328937172237, 5835.416458354173, 5837.445442682938, 5591.6365436246515, 5723.742431590588, 5854.2096816930025, 5856.912146317809, 5872.911906321408, 5327.9610475956815, 5330.840074797762, 5336.67979921206, 5336.786528538853, 5337.852361742244, 5731.254936858182, 5767.596268261182, 5787.565932555075, 5799.33307669615, 5821.214136091573, 5573.386927437979, 5584.553235741212, 5588.357338905997, 5636.098224284095, 5740.024195886709, 5724.427557244242, 5734.942650573525, 5774.335951365647, 5774.94225057744, 5779.971100144472, 5739.282589676291, 5748.540116790647, 5749.195112684228, 5750.166225897222, 5752.942470575241, 5501.0, 5583.134614134816, 5600.831975040755, 5604.719764011783, 5744.281964754406, 4437.001674623249, 4441.555844415532, 4493.191225579427, 4546.88632784183, 4590.793414296298, 3962.9603703962593, 3965.325894597925, 3970.980145099256, 3978.5822488638855, 4011.959880401217, 5223.320968274176, 5336.359636843526, 5352.9732351338, 5355.7054362009685, 5360.973195134077, 5716.657000579979, 5737.942620573825, 5754.251947246831, 5756.079027355687, 5765.1928729977835, 5455.536279416215, 5456.536194423518, 5457.590680698963, 5464.043792336325, 5471.753771080311, 4923.433805112386, 4931.161702510582, 4977.552020318189, 4980.078685443204, 5013.699178049329, 5750.741216645261, 5810.825675229666, 5865.090910908731, 5871.6770577618645, 5994.37059108796, 5733.971330143323, 5759.539236860957, 5800.1589769484035, 5841.561882858888, 5915.91126133117, 5883.441073098049, 5910.674912879833, 5962.135490353788, 5962.910556341745, 5970.940290597038, 5638.407967163553, 5640.294963129609, 5641.153826925994, 5654.123610840326, 5718.342390625131, 5639.661620302795, 5712.914306285492, 5713.200151978644, 5716.914246286392, 5719.342275638355, 5548.528375088163, 5575.1915972184615, 5642.88714225705, 5739.770409183586, 5781.988152073286, 5495.5878309127775, 5601.04782187021, 5602.663840169603, 5608.158776183442, 5618.859528511656, 5387.326584176978, 5492.505674489315, 5498.1752737089755, 5504.862378440571, 5509.173623956439, 5520.089185284543, 5627.718614069198, 5755.65466072037, 5759.2512973313205, 5805.129230615442, 5508.394076651485, 5520.337559492887, 5522.779088836402, 5525.475079867406, 5537.778488860562], "unit": "score", "name": "dojo.html", "value": 5297.3971580124635}, {"lowerIsBetter": false, "replicates": [521.7730287325014, 538.8760585065435, 550.2406678783278, 570.3355590736792, 623.6164758673411, 35038.0, 35509.2898142037, 35552.64447355526, 35607.2878542429, 35689.10777230567, 36007.63992360076, 36280.092997675005, 36281.637183628154, 36459.63540364595, 36645.816770916106, 8205.671773129083, 8432.747017589481, 8435.578221088952, 8442.746717598482, 8447.450915690491, 8176.795580110515, 8357.874631880526, 8455.746327610152, 8462.3653226008, 8484.066752657234, 8374.83250334993, 8427.0, 8445.746627601182, 8483.066862645104, 8498.617562209685, 8408.117147699495, 8434.198751118634, 8447.746567602982, 8450.450720703166, 8454.78863028423, 8283.25450709439, 8432.45189062709, 8439.324854011664, 8458.830823383498, 8485.66057357705, 36203.275934481164, 36677.0, 36679.449808252895, 36741.44887826685, 36867.26265474702, 3180.6183258009187, 3196.568463257454, 3227.8863791991726, 3379.493076038589, 3462.255615042778, 29202.0, 29342.972995945252, 29613.851930740424, 29631.407371852656, 30622.54066189009, 3742.3263812513737, 3807.0, 3903.1413089120633, 3916.5691773904846, 3960.6435420812263, 220731.0, 220916.0, 221274.0, 221606.0, 223325.99999999837, 53083.0, 55015.44984550183, 55580.72209639007, 55636.443635563126, 55652.44347556472, 64789.0, 65597.67201163963, 65799.67100164469, 65993.0, 66312.6684366575, 15570.065796052273, 15653.373865045498, 15721.0, 15763.605909852346, 15768.92115539415, 12015.759684806255, 12016.939915300542, 12077.15459917815, 12093.334866582247, 12099.33453660057, 19354.806451935583, 19504.804951950584, 19587.706184407245, 20121.798782012283, 20489.897550512153, 8043.0, 8076.555789431638, 8145.592720364077, 8174.0, 8257.917420825836, 907.0022974727879, 936.817320622472, 967.5210770668564, 1034.374203606822, 1047.9266451348485, 28018.159455216377, 28333.858330708215, 28609.28476788097, 28684.282892927844, 28788.71211287902, 1056.4770438632927, 1064.9627263045757, 1067.5836423794726, 1079.8488211650376, 1153.3541216918552, 14959.775603365959, 15028.173450460112, 15055.473058442902, 15249.618759530878, 15312.770308445382, 308510.0, 308877.0, 309299.0, 311088.0, 311329.0, 51792.0, 51857.74071129696, 52192.73903630458, 52385.73807131016, 52524.73737631287, 1301.4078594239597, 1301.9544315948897, 1323.2589749740175, 1340.9262490562917, 1348.892088632907, 26992.0, 28430.43139137247, 28453.715462845106, 31046.379072418877, 31470.37059258848, 46320.7683961578, 46533.76733116313, 46802.29796552986, 46991.0, 47091.29363059488, 241686.0, 244559.0, 244953.0, 244983.0, 245069.0, 41955.7902210487, 42932.57067429286, 43329.0, 44287.55712442963, 44394.334084989394, 38880.6111938877, 39306.803465983634, 39489.2102157961, 39743.403848942864, 40278.0, 32981.0, 33662.495062573595, 34041.0, 34228.48657270093, 34363.65636343705, 40447.393289101274, 41565.584344156174, 41707.791461043715, 42794.35808462813, 45235.773821130686, 37068.6293137076, 37327.6267237335, 37679.0, 37862.24275514529, 38127.61872381352, 36279.274414511034, 37392.0, 37645.435318469696, 37673.434898476, 37771.43342849804, 31394.843025784725, 32245.355092897542, 32285.192870178435, 32376.514352284263, 32575.837120814245], "unit": "score", "name": "ext.html", "value": 18450.178077033102}, {"lowerIsBetter": false, "replicates": [372.2331996088059, 372.50828905844287, 373.1771443966055, 375.583102755941, 382.9081020555068, 15749.448769293078, 16938.40715574955, 17059.829401705978, 17539.82460175398, 17646.470605881812, 10968.0, 11780.352080635561, 15801.60495987601, 15948.76076858848, 15950.122743249116, 4738.573528382453, 4976.452590215092, 4980.327655766479, 4991.825286114987, 4992.301077849104, 4868.099401610696, 4949.777260023289, 4993.550580447759, 4994.725290109042, 5152.381714194284, 5094.694318340893, 5296.576273898098, 5345.518903298703, 5446.455354464541, 5477.123660214366, 5240.240165176047, 5256.106461901467, 5259.053370393328, 5537.390887002467, 5980.0431930890845, 5313.1764576490705, 5355.0896347621, 5359.517643412073, 5359.973200133974, 5362.705051222181, 13107.737845243137, 13110.737785244337, 13159.14465559745, 13787.0, 14691.53084691533, 2091.2262462888675, 2113.1336152177532, 2121.95756084879, 2214.900329485161, 2280.0, 9016.819663606691, 9532.999035101284, 9630.3258771886, 9640.276979226515, 9860.506974651238, 1751.036929688666, 1764.214924358661, 1872.447627949758, 1881.4355693292096, 1917.3768525229357, 56598.03648793669, 59037.50587435336, 59681.10478342785, 59782.402175978554, 60166.69916650389, 10290.948545257375, 10312.381257124447, 10314.896851031544, 10336.379817210991, 10395.0, 13538.729225415436, 13553.39009744564, 13602.0, 13621.318934053257, 13629.863701363058, 7373.188949215582, 7441.888371674429, 7640.885386719204, 7693.422993275415, 7714.6914123434435, 7028.718851245892, 7029.191642961125, 7054.4003759681, 7056.223815380304, 7320.084989376328, 4389.297712366006, 4439.178751930903, 4502.144592527409, 4524.0951809637545, 4525.162844873643, 1870.1023508715894, 1880.8025157358554, 1900.429871038683, 1902.8477721782224, 1941.8640695151487, 867.4968518259394, 980.857775622545, 1009.7172791618359, 1016.6238491758097, 1033.4367769565604, 15720.024091228113, 15815.446459373867, 15928.203589820463, 16035.438759643357, 16159.838401616069, 943.6225509796, 954.465499320369, 958.3531116496337, 977.9657711980046, 985.3584067726002, 9257.120573545502, 9524.333296669305, 9525.809483810284, 9656.813251626947, 9669.951650241705, 553321.0, 555486.0, 555572.0, 556763.0, 566297.0, 72429.6378518104, 73812.99999999892, 76372.61813691007, 76890.61554692191, 77171.22828771753, 1130.5760339872547, 1163.7381589142544, 1168.0830548019765, 1185.8280549320473, 1199.57415117632, 15360.539183824503, 15439.150846703538, 15450.0, 15559.611009724847, 16010.759838602196, 33771.81798637036, 33790.831045844614, 34659.4801077979, 34738.82630586831, 34988.30023399467, 44195.0, 44409.333859992774, 44451.55548444474, 45029.32456013097, 45512.317315239634, 7143.4999550031, 7193.568385896863, 7294.416446684147, 7392.8891066635115, 7399.630018499161, 9013.684521041732, 11033.889661103287, 11107.38909359993, 11128.054115400282, 11329.206955513035, 2718.384548550384, 2845.0895713371524, 5610.49505544503, 9488.33581649278, 9901.653442129491, 9926.652567160114, 9977.401355918668, 10138.935411781657, 10330.948345258226, 10462.581496740046, 9743.512824358895, 10269.178465722875, 10312.381257124596, 10352.585896564053, 10390.532426040696, 7425.183229844821, 7453.105627324756, 7507.0, 7509.699612015458, 7529.698812047457, 9829.164521015793, 9829.557669905014, 9932.950335248277, 9966.053224943618, 10009.54957026921], "unit": "score", "name": "jquery.html", "value": 8057.187028818844}, {"lowerIsBetter": false, "replicates": [1447.9420823167077, 1455.1850963460463, 1591.3873158833853, 1745.432734361333, 1753.6229710612215, 6820.556663816861, 6930.653467326639, 7714.267144621266, 7947.1258161602245, 7952.92047079529, 7433.442491813109, 7653.808654783619, 7763.107242667095, 7764.223577642247, 7775.805604859881, 2356.9511567352533, 2397.9520409591796, 2410.4696966667307, 2411.3489357873364, 2425.769551892576, 2343.94140146496, 2379.4884099918513, 2386.7971222446113, 2397.30478161333, 2398.304491697406, 2353.752855950126, 2364.3498038039593, 2392.605220138675, 2409.771071748181, 2413.1433341163897, 2365.089440565395, 2368.917087901924, 2370.5140446208484, 2378.92863214103, 2416.275117464771, 2373.596488596943, 2374.964375534351, 2382.3805810489225, 2397.6643269942047, 2402.4954759500524, 7904.051513818321, 7929.801754956115, 7947.324477419426, 8004.359651227946, 8007.879881801778, 4684.929726054078, 4723.929141062887, 4741.502142275046, 4754.690945088558, 4771.618270538349, 3057.877684892602, 3097.504399296102, 3118.937621247562, 3135.04381163745, 3206.839658017113, 1014.9644762433279, 1022.4734261855151, 1041.0890470838017, 1052.5947510208548, 1059.3855563772993, 10754.838677419844, 10759.30064545802, 10853.457327133612, 10875.78248435027, 10886.29239099456, 4223.767692776927, 4300.80646370914, 4375.78121093944, 4412.933805992912, 4421.115776844644, 8814.515201663842, 8939.284857211538, 9048.41185322965, 9062.410943288665, 9073.727788166365, 4912.803487860517, 4928.383952005999, 4928.457869634337, 4967.130752118364, 4972.378452693413, 4327.242732521796, 4438.889027774331, 4464.084862603158, 4498.3252512123445, 4504.864854054384, 3652.7990960497427, 3673.9081522961606, 3679.5216621839527, 3702.7593206441493, 3709.295233905549, 1149.350616901448, 1154.2266681323533, 1155.3414553704476, 1157.7337212441187, 1157.774234024374, 1034.4982683398546, 1037.7768779712399, 1050.8949105089582, 1182.5920057580122, 1334.652990222549, 7426.925730742623, 7599.582022988679, 7603.2776886195725, 7626.6186690665245, 7682.462227644123, 1108.4291589831244, 1110.7389763405592, 1124.876263611002, 1126.7633796902742, 1157.4675649201292, 5810.564207684356, 5863.589548731547, 5971.402859713994, 5991.400859913973, 6021.217241758543, 9209.677661281823, 9450.291228157916, 9689.515524223902, 9751.463669498246, 9765.072318129767, 9357.90642093584, 9515.0, 9536.952315238519, 9582.185514231229, 9596.280278979104, 7370.189279179286, 7425.777226683208, 7505.0, 7555.24447555251, 7644.847103057908, 7397.03838501013, 7451.3666338361845, 7487.251274872469, 7498.212687667717, 7525.285097915689, 8371.748847534584, 8637.654493820177, 8876.28989680811, 8879.156480134636, 8880.73357799267, 8778.604962776819, 8976.371653984159, 9012.369134160546, 9036.186743193144, 9051.275897928019, 6287.842803929939, 6492.415682588589, 6726.6972986216715, 7067.752628657972, 7236.34872861445, 7581.696732130874, 7619.4285428594185, 7632.618369081412, 7647.349975251944, 7656.425768067528, 6963.61700106499, 7133.464990125865, 7201.603911784902, 7261.3101755333155, 7308.269173082649, 7220.0613920190035, 7274.345308922222, 7276.199618042117, 7311.524750891175, 7350.4854660175415, 6748.932510675027, 6833.077534532775, 6863.965680171567, 6876.243613202644, 6881.277465866012, 6279.340669229665, 6338.429541341301, 6382.425581697669, 6389.840253993687, 6391.456726178327, 6074.119252708244, 6114.052321890114, 6121.755129794937, 6146.631202127886, 6184.381561843779], "unit": "score", "name": "mootools.html", "value": 4568.590742812821}, {"lowerIsBetter": false, "replicates": [351.4219109564766, 354.5090050280362, 359.5739049226665, 360.66818526955205, 364.37145923282355, 6276.843078923023, 6288.6855657217075, 6378.043293505971, 6380.80857574273, 6474.741010359592, 6280.214973128359, 6309.842253943653, 6311.053341998702, 6324.715387807548, 6335.239771227459, 4820.807167713305, 4820.831270905519, 4839.540243676845, 4845.636577256702, 4846.0792449434675, 4827.58965487934, 4842.491538388454, 4844.346013288214, 4844.87887802806, 4852.272159176134, 4624.213883639789, 4700.553447422507, 4725.385699859014, 4727.645426593002, 4790.616750659939, 4703.176944034797, 4710.034442939189, 4711.717296962159, 4718.787654555554, 4719.764011799431, 4091.6317531422314, 4112.321466957948, 4114.238865809834, 4120.896977575555, 4121.443605113302, 5979.820605381846, 6003.429674180946, 6020.69896505173, 6028.125921741367, 6048.727807248684, 5479.589030822664, 5517.648176196817, 5552.250446189753, 5570.721463926788, 5579.163125531162, 6692.293465166352, 6693.531452798306, 6696.83257918556, 6699.765508207238, 6700.028495868072, 4592.770361481913, 4598.195315819718, 4602.677812553123, 4603.353071983623, 4605.37827393301, 6866.279040700704, 6960.721571137148, 7034.437245020386, 7045.365917067488, 7116.715331386738, 4698.671093023524, 4714.57568818808, 4730.621550276039, 4738.928916066262, 4743.407074115736, 4680.953190468052, 4753.0, 4755.690880092783, 4759.024399997992, 4776.331313616097, 5499.202615620713, 5567.3040869891265, 5568.3318001839225, 5571.052921003358, 5572.219889215513, 6658.4673226141795, 6754.290799466084, 6814.1482314710665, 6851.2806155353965, 6859.0, 1639.049351376199, 1668.7246604310396, 1672.3979367427717, 1674.67343867947, 1677.790276215473, 1108.534415545473, 1120.1374941295157, 1120.3278033180027, 1123.9100871930225, 1129.5989923577013, 6251.124842521959, 6296.937030629635, 6303.212098487689, 6311.368863113652, 6312.6212427253595, 6785.016172655036, 6855.280195579492, 6862.936244882051, 6880.793576192722, 6890.000949862242, 6120.908186377208, 6234.501239900797, 6265.906011409833, 6268.279147897959, 6279.843003924847, 3717.628237176261, 3722.8696995605023, 3738.7569807962395, 3745.183585960807, 3746.5691445484117, 7086.043384143075, 7121.750738724223, 7125.821854453577, 7161.785146445615, 7162.068931038932, 6930.0, 7046.788596342118, 7053.259407762213, 7059.0, 7077.469189810785, 7228.421726261887, 7307.817304567428, 7308.817279568053, 7320.487565870444, 7322.414206863545, 6955.408790252885, 6987.580745155307, 7032.085828842218, 7034.437245020284, 7051.294870512907, 6832.555883867532, 6919.135108111486, 6925.3074692530345, 6934.0985671864355, 6935.514513983972, 7271.890921636285, 7283.380912622274, 7284.235155308616, 7284.745033923788, 7286.162091359562, 4721.763911804464, 4764.094821983812, 4768.594669452997, 4788.473267940593, 4789.61683065347, 6838.281980391987, 6986.196587392515, 6986.476014298846, 6992.825179370557, 7009.404200643003, 6769.356911093439, 6779.389854913082, 6800.6599670017295, 6813.250542440229, 6833.077534532775, 6761.256261811295, 6769.93230067693, 6781.864362712817, 6800.965995169992, 6822.727090916308, 6474.5791523550815, 6623.105880706043, 6639.170103737033, 6639.970804525306, 6643.136392268974, 6778.7288508459105, 6794.422474089758, 6828.419584335188, 6833.521653484208, 6841.418479429304, 6626.0, 6660.666966651745, 6662.800115996528, 6676.76631317921, 6677.565958212701], "unit": "score", "name": "prototype.html", "value": 5050.202471725042}, {"lowerIsBetter": false, "replicates": [762.9847403051938, 773.2769860180734, 828.7513745876239, 846.3990566697648, 873.4977388001901, 13364.198148111109, 13545.525906593271, 13549.916006719463, 13554.728905421885, 13641.65895852603, 12532.310722910237, 12627.810582841264, 12694.555690550833, 12698.174618649782, 12778.68053298668, 763.7632333976458, 784.4273680213419, 788.8264581791997, 790.5059337913804, 791.3787676673812, 797.5852556670528, 804.8309854930471, 806.1011971651595, 806.5040000399771, 808.0908977400425, 835.9122292159327, 836.2431999040878, 837.5100566168799, 838.1660248053196, 838.8741688746707, 827.8385714785619, 827.8509868223747, 830.4602008694367, 830.8047608811925, 831.8128421105264, 609.3966972697042, 610.5115907274163, 611.2390074357453, 614.1892701633845, 614.5728718540616, 12631.621051368473, 12702.237865728086, 12706.157607146912, 12723.10938234324, 12783.105182637219, 11202.061618830183, 11409.885901140966, 11456.19806613529, 11459.427028648533, 11476.885231147666, 9059.411138276057, 9140.588673509708, 9176.082391760838, 9331.673391431335, 9364.906350936471, 3506.754527183098, 3513.051476101464, 3514.1390359361862, 3535.611082780892, 3538.43385058392, 43042.569574304485, 47730.761346193394, 49070.99999999964, 49414.25878611824, 49509.50490495085, 9885.901140988643, 9900.207983361313, 10104.141148002502, 10226.437545935045, 10309.53607087683, 17789.0, 17818.376356827448, 17828.46514604564, 17829.821701782817, 17845.643087138185, 7324.560526368435, 7429.0, 7638.961805191049, 7799.0, 7799.688012479551, 4173.812178451977, 4174.3947127666925, 4202.831886724497, 4219.852305169305, 4232.36514522824, 3204.7436205103536, 3250.6911843375315, 3265.134739294089, 3270.035339574831, 3271.084096452997, 569.7265312649952, 578.6296770067161, 580.994190058094, 597.202734349648, 609.3784339973291, 646.9482441404676, 663.9900401493982, 672.8082496488478, 680.9591424514545, 692.19705142036, 7900.604969751489, 8326.916730832614, 8367.163283671705, 8531.146885311418, 8549.145085491526, 648.8410339466766, 654.4796886475264, 683.641088428579, 711.1040089487283, 726.6584705188659, 3848.5574158972076, 3930.4890364252465, 3937.448757173998, 4039.6566291864933, 4042.8584999524874, 57198.14202786962, 57275.71362143163, 57622.0, 58046.4195358041, 58092.12861807076, 45726.5427345729, 52247.216291755656, 52403.0, 52664.0, 57439.0, 50892.491075089514, 51543.48456515462, 54633.1805022925, 56137.438625614035, 56522.71738641363, 8484.533350665773, 8810.471371717718, 8876.28989680811, 8879.934407871096, 9014.684486042957, 36571.63428365682, 37082.44376334411, 37148.44277335896, 37219.0, 38071.0, 44737.0, 44795.0, 44936.55063449324, 45230.0, 45244.54755452535, 10859.131269498263, 10927.781444371227, 10957.232993690364, 11110.888891111308, 11332.0, 11202.38386888729, 11205.0, 11224.326540407601, 11437.656870293904, 11695.0, 10773.515191816543, 10882.673519794418, 11171.832422513506, 11340.09279257674, 11462.312261264016, 11093.22669332667, 11133.665990020312, 11286.604968826052, 11421.200515963803, 11821.704457388634, 10419.374837509773, 10599.417032063311, 10614.575416983234, 10844.240903136704, 11312.20814542974, 8924.330675199515, 9435.481048542397, 9605.327627066317, 9662.227021838376, 9790.559424826042, 8215.178482151738, 8423.824277639658, 8552.700655477029, 9090.999830317349, 9651.03653008988], "unit": "score", "name": "yui.html", "value": 6261.83333481986}], "name": "dromaeo_css", "value": 6961.11963293102}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 105.0, 112.0, 109.0, 113.0, 122.0, 112.0, 111.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [150.0, 127.0, 150.0, 161.0, 128.0, 147.0, 153.0, 129.0, 160.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 143.5}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 163.0, 162.0, 163.0, 163.0, 161.0, 164.0, 171.0, 161.0], "unit": "score", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 75.0, 72.0, 129.0, 71.0, 72.0, 72.0, 73.0], "unit": "score", "name": "audio-fft", "value": 78.3}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 146.0, 95.0, 96.0, 96.0, 140.0, 97.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 109.3}, {"lowerIsBetter": true, "replicates": [110.0, 111.0, 110.0, 111.0, 110.0, 111.0, 110.0, 110.0, 111.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 147.0, 149.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 99.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [58.0, 62.0, 59.0, 57.0, 61.0, 59.0, 58.0, 58.0, 58.0, 60.0], "unit": "score", "name": "json-parse-financial", "value": 59.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [89.0, 84.0, 90.0, 91.0, 84.0, 83.0, 84.0, 84.0, 91.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [121.0, 117.0, 120.0, 118.0, 118.0, 125.0, 131.0, 114.0, 116.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.6}, {"lowerIsBetter": true, "replicates": [142.0, 143.0, 144.0, 143.0, 146.0, 141.0, 152.0, 160.0, 140.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.3}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 66.0, 66.0, 68.0, 67.0, 67.0, 66.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.6}], "name": "kraken", "value": 1505.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [171.6148961729878], "unit": "score", "name": "Richards", "value": 205.70475399999998}, {"lowerIsBetter": false, "replicates": [187.4062968515742], "unit": "score", "name": "DeltaBlue", "value": 352.8056479999999}, {"lowerIsBetter": false, "replicates": [280.8988764044944], "unit": "score", "name": "Encrypt", "value": 947.6043599999998}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1067.2358591248667], "unit": "score", "name": "RayTrace", "value": 693.3696929999998}, {"lowerIsBetter": false, "replicates": [700.2801120448179], "unit": "score", "name": "Earley", "value": 951.7091640000002}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [41428.57142857143], "unit": "score", "name": "RegExp", "value": 21.989293103448276}, {"lowerIsBetter": false, "replicates": [564.3340857787811], "unit": "score", "name": "Splay", "value": 144.40205199999994}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20492.869536858747}]} 05:32:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "20492.87"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1505.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6961.12"}}} 05:32:39 INFO - Return code: 0 05:32:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:32:40 INFO - # TBPL SUCCESS # 05:32:40 INFO - Running post-action listener: _resource_record_post_action 05:32:40 INFO - Running post-run listener: _resource_record_post_run 05:32:41 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 0; Write bytes: 554156032; Read time: 0; Write time: 365032 05:32:41 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 239271936; Read time: 0; Write time: 203352 05:32:41 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 314884096; Read time: 0; Write time: 161680 05:32:41 INFO - Running post-run listener: _upload_blobber_files 05:32:41 INFO - Blob upload gear active. 05:32:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:32:41 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:41 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:41 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:41 INFO - (blobuploader) - INFO - Open directory for files ... 05:32:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:32:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:32:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:42 INFO - (blobuploader) - INFO - Done attempting. 05:32:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:32:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:32:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:43 INFO - (blobuploader) - INFO - Done attempting. 05:32:43 INFO - (blobuploader) - INFO - Iteration through files over. 05:32:43 INFO - Return code: 0 05:32:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:32:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:32:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fba67d0f684b7d4e42506c78665a83ee144e41ece6d7fe4602381af241fee45701c0a3295679d5f0eeea1502565054fed9364874e6ce4cb28f51328d642ec8fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d73c6c391389ae382db861801ee17126992783e59f9737f0e73c29a113d12072b4cdfc97ca576059114c4a34253a2759b4f99d8f0c977205ac8e8b420f35c749"} 05:32:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:32:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:32:43 INFO - Contents: 05:32:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fba67d0f684b7d4e42506c78665a83ee144e41ece6d7fe4602381af241fee45701c0a3295679d5f0eeea1502565054fed9364874e6ce4cb28f51328d642ec8fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d73c6c391389ae382db861801ee17126992783e59f9737f0e73c29a113d12072b4cdfc97ca576059114c4a34253a2759b4f99d8f0c977205ac8e8b420f35c749"} 05:32:43 INFO - Copying logs to upload dir... 05:32:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1276.456828 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-14 05:32:43.278097) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 05:32:43.281506) ========= 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=41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fba67d0f684b7d4e42506c78665a83ee144e41ece6d7fe4602381af241fee45701c0a3295679d5f0eeea1502565054fed9364874e6ce4cb28f51328d642ec8fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d73c6c391389ae382db861801ee17126992783e59f9737f0e73c29a113d12072b4cdfc97ca576059114c4a34253a2759b4f99d8f0c977205ac8e8b420f35c749"} 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.011202 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fba67d0f684b7d4e42506c78665a83ee144e41ece6d7fe4602381af241fee45701c0a3295679d5f0eeea1502565054fed9364874e6ce4cb28f51328d642ec8fb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d73c6c391389ae382db861801ee17126992783e59f9737f0e73c29a113d12072b4cdfc97ca576059114c4a34253a2759b4f99d8f0c977205ac8e8b420f35c749"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-14 05:32:43.306207) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:32:43.306536) ========= 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=41bf3e9aed84707956354da8000001c5-1452776985.199685-1846096583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004721 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-14 05:32:43.391286) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 05:32:43.391825) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-14 05:32:43.392339) ========= ========= Total master_lag: 0.25 =========