builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1451976205.97 results: success (0) buildid: 20160104203144 builduid: 4afe12ccb5e747a4a1509b339f3952de revision: e5c4bd0666192024af9ea7842c0b710c1ac749ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:25.967843) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:25.968540) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:25.968932) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006345 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:25.998881) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:25.999225) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:26.024715) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:26.025088) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015746 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:26.078663) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:26.079184) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:26.079979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:26.080372) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 22:43:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-01-04 22:43:26 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161908 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:26.258139) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:26.258709) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.105838 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:26.378946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:26.379340) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e5c4bd0666192024af9ea7842c0b710c1ac749ba --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 e5c4bd0666192024af9ea7842c0b710c1ac749ba --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=8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 22:43:26,598 truncating revision to first 12 chars 2016-01-04 22:43:26,599 Setting DEBUG logging. 2016-01-04 22:43:26,599 attempt 1/10 2016-01-04 22:43:26,599 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e5c4bd066619?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 22:43:26,843 unpacking tar archive at: fx-team-e5c4bd066619/testing/mozharness/ program finished with exit code 0 elapsedTime=0.537973 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:26.931288) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:26.931653) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:26.941355) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:26.941656) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 22:43:26.942136) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-04 22:43:26.942715) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:43:27 INFO - MultiFileLogger online at 20160104 22:43:27 in /builds/slave/test-pgo 22:43: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 22:43:27 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:43:27 INFO - {'append_to_log': False, 22:43:27 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:43:27 INFO - 'blob_upload_branch': 'Fx-Team', 22:43:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:43:27 INFO - 'branch': 'Fx-Team', 22:43:27 INFO - 'buildbot_json_path': 'buildprops.json', 22:43:27 INFO - 'config_files': ('talos/linux_config.py',), 22:43:27 INFO - 'default_actions': ('clobber', 22:43:27 INFO - 'read-buildbot-config', 22:43:27 INFO - 'download-and-extract', 22:43:27 INFO - 'populate-webroot', 22:43:27 INFO - 'create-virtualenv', 22:43:27 INFO - 'install', 22:43:27 INFO - 'run-tests'), 22:43:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:43:27 INFO - 'download_minidump_stackwalk': True, 22:43:27 INFO - 'download_symbols': 'ondemand', 22:43:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:43:27 INFO - 'tooltool.py': '/tools/tooltool.py', 22:43:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:43:27 INFO - '/tools/misc-python/virtualenv.py')}, 22:43:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:43:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:43:27 INFO - 'installer_path': 'installer.exe', 22:43:27 INFO - 'log_level': 'info', 22:43:27 INFO - 'log_name': 'talos', 22:43:27 INFO - 'log_to_console': True, 22:43:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:43:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:43:27 INFO - 'opt_config_files': (), 22:43:27 INFO - 'pip_index': False, 22:43:27 INFO - 'sps_profile': False, 22:43:27 INFO - 'sps_profile_interval': 0, 22:43:27 INFO - 'suite': 'dromaeojs-e10s', 22:43:27 INFO - 'system_bits': '32', 22:43:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:43:27 INFO - 'title': 'talos-linux64-ix-041', 22:43:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:43:27 INFO - 'use_talos_json': True, 22:43:27 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:43:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:43:27 INFO - 'work_dir': 'build'} 22:43:27 INFO - ##### 22:43:27 INFO - ##### Running clobber step. 22:43:27 INFO - ##### 22:43:27 INFO - Running pre-action listener: _resource_record_pre_action 22:43:27 INFO - Running main action method: clobber 22:43:27 INFO - rmtree: /builds/slave/test-pgo/build 22:43:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:43:28 INFO - Running post-action listener: _resource_record_post_action 22:43:28 INFO - ##### 22:43:28 INFO - ##### Running read-buildbot-config step. 22:43:28 INFO - ##### 22:43:28 INFO - Running pre-action listener: _resource_record_pre_action 22:43:28 INFO - Running main action method: read_buildbot_config 22:43:28 INFO - Using buildbot properties: 22:43:28 INFO - { 22:43:28 INFO - "project": "", 22:43:28 INFO - "product": "firefox", 22:43:28 INFO - "script_repo_revision": "production", 22:43:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:43:28 INFO - "repository": "", 22:43:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 22:43:28 INFO - "buildid": "20160104203144", 22:43:28 INFO - "pgo_build": "True", 22:43:28 INFO - "basedir": "/builds/slave/test-pgo", 22:43:28 INFO - "buildnumber": 423, 22:43:28 INFO - "slavename": "talos-linux64-ix-041", 22:43:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:43:28 INFO - "platform": "ubuntu64_hw", 22:43:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 22:43:28 INFO - "branch": "fx-team", 22:43:28 INFO - "repo_path": "integration/fx-team", 22:43:28 INFO - "revision": "e5c4bd0666192024af9ea7842c0b710c1ac749ba", 22:43:28 INFO - "stage_platform": "linux64-pgo", 22:43:28 INFO - "builduid": "4afe12ccb5e747a4a1509b339f3952de", 22:43:28 INFO - "slavebuilddir": "test" 22:43:28 INFO - } 22:43:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:43:28 INFO - Running post-action listener: _resource_record_post_action 22:43:28 INFO - ##### 22:43:28 INFO - ##### Running download-and-extract step. 22:43:28 INFO - ##### 22:43:28 INFO - Running pre-action listener: _resource_record_pre_action 22:43:28 INFO - Running main action method: download_and_extract 22:43:28 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:43: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')]} 22:43:28 INFO - https://queue.taskcluster.net/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:43:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/test_packages.json 22:43:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/test_packages.json 22:43:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:43:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:43:37 INFO - Downloaded 1302 bytes. 22:43:37 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:43:37 INFO - Using the following test package requirements: 22:43:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:43:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:43:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:43:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:43:37 INFO - u'jsshell-linux-x86_64.zip'], 22:43:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:43:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:43:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:43:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:43:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:43:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:43:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:43:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:43:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:43:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:43:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:43:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:43:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:43:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:37 INFO - https://queue.taskcluster.net/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:43:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:43:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:43:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/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 22:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/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 22:43:46 INFO - Downloaded 23198177 bytes. 22:43:46 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 22:43:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:43:46 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 22:43:48 INFO - Return code: 0 22:43:48 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 22:43:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:48 INFO - https://queue.taskcluster.net/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:43:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:43:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:43:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/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 22:43:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/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 22:43:49 INFO - Downloaded 23198177 bytes. 22:43:49 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 22:43:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:43:49 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 22:43:50 INFO - Return code: 0 22:43:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:50 INFO - https://queue.taskcluster.net/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:43:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:43:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:43:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/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 22:43:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/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 22:43:52 INFO - Downloaded 11132285 bytes. 22:43:52 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 22:43:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:43:52 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 22:43:52 INFO - Return code: 0 22:43:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:52 INFO - https://queue.taskcluster.net/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:43:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:43:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:43:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/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 22:43:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ANUwb1ljRzSi650wroDu2A/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 22:43:53 INFO - Downloaded 54982386 bytes. 22:43:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:43:53 INFO - mkdir: /builds/slave/test-pgo/properties 22:43:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:43:53 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:43:53 INFO - Contents: 22:43:53 INFO - build_url:https://queue.taskcluster.net/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:43:53 INFO - Running post-action listener: _resource_record_post_action 22:43:53 INFO - Running post-action listener: set_extra_try_arguments 22:43:53 INFO - ##### 22:43:53 INFO - ##### Running populate-webroot step. 22:43:53 INFO - ##### 22:43:53 INFO - Running pre-action listener: _resource_record_pre_action 22:43:53 INFO - Running main action method: populate_webroot 22:43:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:43:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:43:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:43:53 INFO - '--tppagecycles', 22:43:53 INFO - '7'], 22:43:53 INFO - 'tests': ['tsvgm']}}, 22:43:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:43:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:43:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:43:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:43:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:43:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:43:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:43:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:43:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:43:53 INFO - 'talos_options': ['--e10s'], 22:43:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:43:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:43:53 INFO - 'tests': ['damp', 'tps']}, 22:43:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:43:53 INFO - 'talos_options': ['--e10s'], 22:43:53 INFO - 'tests': ['damp', 'tps']}, 22:43:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:43:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:43:53 INFO - 'other': {'tests': ['a11yr', 22:43:53 INFO - 'ts_paint', 22:43:53 INFO - 'tpaint', 22:43:53 INFO - 'sessionrestore', 22:43:53 INFO - 'sessionrestore_no_auto_restore']}, 22:43:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:43:53 INFO - 'tests': ['a11yr', 22:43:53 INFO - 'ts_paint', 22:43:53 INFO - 'tpaint', 22:43:53 INFO - 'sessionrestore', 22:43:53 INFO - 'sessionrestore_no_auto_restore']}, 22:43:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:43:53 INFO - 'tests': ['a11yr', 22:43:53 INFO - 'ts_paint', 22:43:53 INFO - 'tpaint', 22:43:53 INFO - 'sessionrestore', 22:43:53 INFO - 'sessionrestore_no_auto_restore']}, 22:43:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:43:53 INFO - 'tests': ['a11yr', 22:43:53 INFO - 'ts_paint', 22:43:53 INFO - 'tpaint', 22:43:53 INFO - 'sessionrestore', 22:43:53 INFO - 'sessionrestore_no_auto_restore']}, 22:43:53 INFO - 'other_l64': {'tests': ['a11yr', 22:43:53 INFO - 'ts_paint', 22:43:53 INFO - 'tpaint', 22:43:53 INFO - 'sessionrestore', 22:43:53 INFO - 'sessionrestore_no_auto_restore']}, 22:43:53 INFO - 'other_nol64': {'tests': ['a11yr', 22:43:53 INFO - 'ts_paint', 22:43:53 INFO - 'tpaint', 22:43:53 INFO - 'sessionrestore', 22:43:53 INFO - 'sessionrestore_no_auto_restore']}, 22:43:53 INFO - 'svgr': {'tests': ['tsvgx', 22:43:53 INFO - 'tsvgr_opacity', 22:43:53 INFO - 'tart', 22:43:53 INFO - 'tscrollx', 22:43:53 INFO - 'cart']}, 22:43:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:43:53 INFO - 'tests': ['tsvgx', 22:43:53 INFO - 'tsvgr_opacity', 22:43:53 INFO - 'tart', 22:43:53 INFO - 'tscrollx', 22:43:53 INFO - 'cart']}, 22:43:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:43:53 INFO - 'tests': ['tp5o']}, 22:43:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:43:53 INFO - 'talos_options': ['--e10s'], 22:43:53 INFO - 'tests': ['tp5o']}, 22:43:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:43:53 INFO - 'talos_options': ['--xperf_path', 22:43:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:43:53 INFO - 'tests': ['tp5n']}, 22:43:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:43:53 INFO - 'talos_options': ['--e10s', 22:43:53 INFO - '--xperf_path', 22:43:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:43:53 INFO - 'tests': ['tp5n']}}, 22:43:53 INFO - 'talos.zip': {'path': '', 22:43:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:43:53 INFO - Running post-action listener: _resource_record_post_action 22:43:53 INFO - ##### 22:43:53 INFO - ##### Running create-virtualenv step. 22:43:53 INFO - ##### 22:43:53 INFO - Running pre-action listener: _resource_record_pre_action 22:43:53 INFO - Running main action method: create_virtualenv 22:43:53 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:43:53 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 22:43:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:43:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:43:53 INFO - Using real prefix '/usr' 22:43:53 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:43:54 INFO - Installing distribute.............................................................................................................................................................................................done. 22:43:56 INFO - Installing pip.................done. 22:43:56 INFO - Return code: 0 22:43:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe03a4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243e840>, '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 0x23ab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23abb60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', '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 22:43:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 22:43:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:43:56 INFO - Using env: {'DISPLAY': ':0', 22:43:56 INFO - 'HOME': '/home/cltbld', 22:43:56 INFO - 'LANG': 'en_US.UTF-8', 22:43:56 INFO - 'LANGUAGE': 'en_US:en', 22:43:56 INFO - 'LOGNAME': 'cltbld', 22:43:56 INFO - 'MAIL': '/var/mail/cltbld', 22:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:56 INFO - 'MOZ_NO_REMOTE': '1', 22:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:43:56 INFO - 'NO_EM_RESTART': '1', 22:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:43:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:43:56 INFO - 'SHELL': '/bin/bash', 22:43:56 INFO - 'SHLVL': '1', 22:43:56 INFO - 'TERM': 'linux', 22:43:56 INFO - 'TMOUT': '86400', 22:43:56 INFO - 'USER': 'cltbld', 22:43:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', 22:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:56 INFO - '_': '/tools/buildbot/bin/python'} 22:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:56 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 22:43:56 INFO - Cleaning up... 22:43:56 INFO - Return code: 0 22:43:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe03a4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243e840>, '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 0x23ab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23abb60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', '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 22:43:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 22:43:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:43:56 INFO - Using env: {'DISPLAY': ':0', 22:43:56 INFO - 'HOME': '/home/cltbld', 22:43:56 INFO - 'LANG': 'en_US.UTF-8', 22:43:56 INFO - 'LANGUAGE': 'en_US:en', 22:43:56 INFO - 'LOGNAME': 'cltbld', 22:43:56 INFO - 'MAIL': '/var/mail/cltbld', 22:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:56 INFO - 'MOZ_NO_REMOTE': '1', 22:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:43:56 INFO - 'NO_EM_RESTART': '1', 22:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:43:56 INFO - 'PWD': '/builds/slave/test-pgo', 22:43:56 INFO - 'SHELL': '/bin/bash', 22:43:56 INFO - 'SHLVL': '1', 22:43:56 INFO - 'TERM': 'linux', 22:43:56 INFO - 'TMOUT': '86400', 22:43:56 INFO - 'USER': 'cltbld', 22:43:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', 22:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:56 INFO - '_': '/tools/buildbot/bin/python'} 22:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:56 INFO - Downloading/unpacking psutil>=0.7.1 22:43: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 22:43: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 22:43: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 22:43: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 22:43: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 22:43: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 22:43:58 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 22:43:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:43:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:43:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:43:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:43:58 INFO - Installing collected packages: psutil 22:43:58 INFO - Running setup.py install for psutil 22:43:58 INFO - building 'psutil._psutil_linux' extension 22:43:58 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 22:43:58 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 22:43:58 INFO - building 'psutil._psutil_posix' extension 22:43:58 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 22:43:58 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 22:43:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:43:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:43:59 INFO - Successfully installed psutil 22:43:59 INFO - Cleaning up... 22:43:59 INFO - Return code: 0 22:43:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:43: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')]} 22:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43: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')]} 22:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:43:59 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 0x7fe03a4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243e840>, '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 0x23ab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23abb60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', '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 22:43:59 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 22:43:59 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 22:43:59 INFO - Using env: {'DISPLAY': ':0', 22:43:59 INFO - 'HOME': '/home/cltbld', 22:43:59 INFO - 'LANG': 'en_US.UTF-8', 22:43:59 INFO - 'LANGUAGE': 'en_US:en', 22:43:59 INFO - 'LOGNAME': 'cltbld', 22:43:59 INFO - 'MAIL': '/var/mail/cltbld', 22:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:43:59 INFO - 'MOZ_NO_REMOTE': '1', 22:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:43:59 INFO - 'NO_EM_RESTART': '1', 22:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:43:59 INFO - 'PWD': '/builds/slave/test-pgo', 22:43:59 INFO - 'SHELL': '/bin/bash', 22:43:59 INFO - 'SHLVL': '1', 22:43:59 INFO - 'TERM': 'linux', 22:43:59 INFO - 'TMOUT': '86400', 22:43:59 INFO - 'USER': 'cltbld', 22:43:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', 22:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:43:59 INFO - '_': '/tools/buildbot/bin/python'} 22:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:43:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:43:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:43:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:44:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:44:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:44:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:44:01 INFO - Installing collected packages: mozsystemmonitor 22:44:01 INFO - Running setup.py install for mozsystemmonitor 22:44:01 INFO - Successfully installed mozsystemmonitor 22:44:01 INFO - Cleaning up... 22:44:02 INFO - Return code: 0 22:44:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:44: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')]} 22:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44: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')]} 22:44:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44: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', '--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 0x7fe03a4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243e840>, '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 0x23ab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23abb60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', '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 22:44:02 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 22:44:02 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 22:44:02 INFO - Using env: {'DISPLAY': ':0', 22:44:02 INFO - 'HOME': '/home/cltbld', 22:44:02 INFO - 'LANG': 'en_US.UTF-8', 22:44:02 INFO - 'LANGUAGE': 'en_US:en', 22:44:02 INFO - 'LOGNAME': 'cltbld', 22:44:02 INFO - 'MAIL': '/var/mail/cltbld', 22:44:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:02 INFO - 'MOZ_NO_REMOTE': '1', 22:44:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:02 INFO - 'NO_EM_RESTART': '1', 22:44:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:44:02 INFO - 'PWD': '/builds/slave/test-pgo', 22:44:02 INFO - 'SHELL': '/bin/bash', 22:44:02 INFO - 'SHLVL': '1', 22:44:02 INFO - 'TERM': 'linux', 22:44:02 INFO - 'TMOUT': '86400', 22:44:02 INFO - 'USER': 'cltbld', 22:44:02 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', 22:44:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:02 INFO - '_': '/tools/buildbot/bin/python'} 22:44:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:02 INFO - Downloading/unpacking blobuploader==1.2.4 22:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:04 INFO - Downloading blobuploader-1.2.4.tar.gz 22:44:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:44:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:44:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:44:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:44:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:05 INFO - Downloading docopt-0.6.1.tar.gz 22:44:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:44:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:44:05 INFO - Installing collected packages: blobuploader, requests, docopt 22:44:05 INFO - Running setup.py install for blobuploader 22:44:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:44:05 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:44:05 INFO - Running setup.py install for requests 22:44:05 INFO - Running setup.py install for docopt 22:44:05 INFO - Successfully installed blobuploader requests docopt 22:44:05 INFO - Cleaning up... 22:44:05 INFO - Return code: 0 22:44:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:44: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')]} 22:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44: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')]} 22:44:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:05 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 0x7fe03a4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243e840>, '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 0x23ab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23abb60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', '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 22:44:05 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 22:44:05 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 22:44:05 INFO - Using env: {'DISPLAY': ':0', 22:44:05 INFO - 'HOME': '/home/cltbld', 22:44:05 INFO - 'LANG': 'en_US.UTF-8', 22:44:05 INFO - 'LANGUAGE': 'en_US:en', 22:44:05 INFO - 'LOGNAME': 'cltbld', 22:44:05 INFO - 'MAIL': '/var/mail/cltbld', 22:44:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:05 INFO - 'MOZ_NO_REMOTE': '1', 22:44:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:05 INFO - 'NO_EM_RESTART': '1', 22:44:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:44:05 INFO - 'PWD': '/builds/slave/test-pgo', 22:44:05 INFO - 'SHELL': '/bin/bash', 22:44:05 INFO - 'SHLVL': '1', 22:44:05 INFO - 'TERM': 'linux', 22:44:05 INFO - 'TMOUT': '86400', 22:44:05 INFO - 'USER': 'cltbld', 22:44:05 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', 22:44:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:05 INFO - '_': '/tools/buildbot/bin/python'} 22:44:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:44:06 INFO - Running setup.py (path:/tmp/pip-plwR6y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:44:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:44:06 INFO - Running setup.py (path:/tmp/pip-U_Bm8m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:44:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:44:06 INFO - Running setup.py (path:/tmp/pip-6xsZnB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:44:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:44:06 INFO - Running setup.py (path:/tmp/pip-896nOo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:44:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:44:06 INFO - Running setup.py (path:/tmp/pip-6kLwSM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:44:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:44:06 INFO - Running setup.py (path:/tmp/pip-jWh9aH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:44:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:44:06 INFO - Running setup.py (path:/tmp/pip-ZenjgT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:44:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:44:06 INFO - Running setup.py (path:/tmp/pip-o9QfpT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:44:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:44:06 INFO - Running setup.py (path:/tmp/pip-mHDZkZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:44:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:44:06 INFO - Running setup.py (path:/tmp/pip-lDOwz1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:44:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:44:06 INFO - Running setup.py (path:/tmp/pip-VQeqne-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:44:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:44:06 INFO - Running setup.py (path:/tmp/pip-WCyCN3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:44:07 INFO - Running setup.py (path:/tmp/pip-137DvB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:44:07 INFO - Running setup.py (path:/tmp/pip-9H9THD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:44:07 INFO - Running setup.py (path:/tmp/pip-YpZyaK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:44:07 INFO - Running setup.py (path:/tmp/pip-mzMNUD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:44:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:44:07 INFO - Running setup.py (path:/tmp/pip-wt5j2U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:44:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:44:07 INFO - Running setup.py install for manifestparser 22:44:07 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:44:07 INFO - Running setup.py install for mozcrash 22:44:07 INFO - Running setup.py install for mozdebug 22:44:07 INFO - Running setup.py install for mozdevice 22:44:07 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:44:07 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:44:07 INFO - Running setup.py install for mozfile 22:44:07 INFO - Running setup.py install for mozhttpd 22:44:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:44:07 INFO - Running setup.py install for mozinfo 22:44:08 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:44:08 INFO - Running setup.py install for mozInstall 22:44:08 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:44:08 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:44:08 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:44:08 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:44:08 INFO - Running setup.py install for mozleak 22:44:08 INFO - Running setup.py install for mozlog 22:44:08 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:44:08 INFO - Running setup.py install for moznetwork 22:44:08 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:44:08 INFO - Running setup.py install for mozprocess 22:44:08 INFO - Running setup.py install for mozprofile 22:44:08 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:44:08 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:44:08 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:44:08 INFO - Running setup.py install for mozrunner 22:44:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:44:08 INFO - Running setup.py install for mozscreenshot 22:44:08 INFO - Running setup.py install for moztest 22:44:09 INFO - Running setup.py install for mozversion 22:44:09 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:44:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:44:09 INFO - Cleaning up... 22:44:09 INFO - Return code: 0 22:44:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe03a4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243e840>, '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 0x23ab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23abb60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', '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 22:44:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 22:44:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:44:09 INFO - Using env: {'DISPLAY': ':0', 22:44:09 INFO - 'HOME': '/home/cltbld', 22:44:09 INFO - 'LANG': 'en_US.UTF-8', 22:44:09 INFO - 'LANGUAGE': 'en_US:en', 22:44:09 INFO - 'LOGNAME': 'cltbld', 22:44:09 INFO - 'MAIL': '/var/mail/cltbld', 22:44:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:09 INFO - 'MOZ_NO_REMOTE': '1', 22:44:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:09 INFO - 'NO_EM_RESTART': '1', 22:44:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:44:09 INFO - 'PWD': '/builds/slave/test-pgo', 22:44:09 INFO - 'SHELL': '/bin/bash', 22:44:09 INFO - 'SHLVL': '1', 22:44:09 INFO - 'TERM': 'linux', 22:44:09 INFO - 'TMOUT': '86400', 22:44:09 INFO - 'USER': 'cltbld', 22:44:09 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', 22:44:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:09 INFO - '_': '/tools/buildbot/bin/python'} 22:44:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:44:09 INFO - Running setup.py (path:/tmp/pip-cJ35Hm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 22:44:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:44:09 INFO - Running setup.py (path:/tmp/pip-6htP3C-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 22:44:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:44:09 INFO - Running setup.py (path:/tmp/pip-BoIzlF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:44:09 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)) 22:44:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:44:09 INFO - Running setup.py (path:/tmp/pip-QYeysb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:44:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:44:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:44:09 INFO - Running setup.py (path:/tmp/pip-pAQtge-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:44:09 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)) 22:44:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:44:09 INFO - Running setup.py (path:/tmp/pip-ncTaw_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:44:09 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)) 22:44:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:44:09 INFO - Running setup.py (path:/tmp/pip-CGI54S-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:44:09 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)) 22:44:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:44:09 INFO - Running setup.py (path:/tmp/pip-9l76PI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:44:09 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)) 22:44:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:44:09 INFO - Running setup.py (path:/tmp/pip-TuREl6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 22:44:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:44:10 INFO - Running setup.py (path:/tmp/pip-f5sRwp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:44:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:44:10 INFO - Running setup.py (path:/tmp/pip-O4tewR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 22:44:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:44:10 INFO - Running setup.py (path:/tmp/pip-ayEqSd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 22:44:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:44:10 INFO - Running setup.py (path:/tmp/pip-OqBrjf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 22:44:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:44:10 INFO - Running setup.py (path:/tmp/pip-pZIg8H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 22:44:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:44:10 INFO - Running setup.py (path:/tmp/pip-pP3qAg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 22:44:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:44:10 INFO - Running setup.py (path:/tmp/pip-N5DEQd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:44:10 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)) 22:44:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:44:10 INFO - Running setup.py (path:/tmp/pip-7_9R1j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:44:10 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)) 22:44:10 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)) 22:44:10 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)) 22:44:10 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)) 22:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:44:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 22:44:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:44: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 22:44: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 22:44: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 22:44: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 22:44: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 22:44: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 22:44:12 INFO - Downloading blessings-1.5.1.tar.gz 22:44:12 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 22:44:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:44:12 INFO - Installing collected packages: blessings 22:44:12 INFO - Running setup.py install for blessings 22:44:12 INFO - Successfully installed blessings 22:44:12 INFO - Cleaning up... 22:44:12 INFO - Return code: 0 22:44:12 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:44:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:44:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:44:12 INFO - Reading from file tmpfile_stdout 22:44:12 INFO - Current package versions: 22:44:12 INFO - argparse == 1.2.1 22:44:12 INFO - blessings == 1.5.1 22:44:12 INFO - blobuploader == 1.2.4 22:44:12 INFO - docopt == 0.6.1 22:44:12 INFO - manifestparser == 1.1 22:44:12 INFO - mozInstall == 1.12 22:44:12 INFO - mozcrash == 0.16 22:44:12 INFO - mozdebug == 0.1 22:44:12 INFO - mozdevice == 0.47 22:44:12 INFO - mozfile == 1.2 22:44:12 INFO - mozhttpd == 0.7 22:44:12 INFO - mozinfo == 0.9 22:44:12 INFO - mozleak == 0.1 22:44:12 INFO - mozlog == 3.1 22:44:12 INFO - moznetwork == 0.27 22:44:12 INFO - mozprocess == 0.22 22:44:12 INFO - mozprofile == 0.28 22:44:12 INFO - mozrunner == 6.11 22:44:12 INFO - mozscreenshot == 0.1 22:44:12 INFO - mozsystemmonitor == 0.0 22:44:12 INFO - moztest == 0.7 22:44:12 INFO - mozversion == 1.4 22:44:12 INFO - psutil == 3.1.1 22:44:12 INFO - requests == 1.2.3 22:44:12 INFO - wsgiref == 0.1.2 22:44:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:44:12 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')]} 22:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:12 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')]} 22:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:12 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 0x7fe03a4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243e840>, '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 0x23ab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23abb60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', '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 22:44:12 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 22:44:12 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 22:44:12 INFO - Using env: {'DISPLAY': ':0', 22:44:12 INFO - 'HOME': '/home/cltbld', 22:44:12 INFO - 'LANG': 'en_US.UTF-8', 22:44:12 INFO - 'LANGUAGE': 'en_US:en', 22:44:12 INFO - 'LOGNAME': 'cltbld', 22:44:12 INFO - 'MAIL': '/var/mail/cltbld', 22:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:12 INFO - 'MOZ_NO_REMOTE': '1', 22:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:12 INFO - 'NO_EM_RESTART': '1', 22:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:44:12 INFO - 'PWD': '/builds/slave/test-pgo', 22:44:12 INFO - 'SHELL': '/bin/bash', 22:44:12 INFO - 'SHLVL': '1', 22:44:12 INFO - 'TERM': 'linux', 22:44:12 INFO - 'TMOUT': '86400', 22:44:12 INFO - 'USER': 'cltbld', 22:44:12 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', 22:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:12 INFO - '_': '/tools/buildbot/bin/python'} 22:44:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:12 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)) 22:44:12 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)) 22:44:12 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)) 22:44:12 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)) 22:44:12 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)) 22:44:12 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)) 22:44:12 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)) 22:44:12 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)) 22:44:12 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)) 22:44:12 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)) 22:44:12 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)) 22:44:12 INFO - Cleaning up... 22:44:12 INFO - Return code: 0 22:44:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:44:12 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')]} 22:44:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:12 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')]} 22:44:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:12 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 0x7fe03a4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243e840>, '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 0x23ab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23abb60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', '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 22:44:12 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 22:44:12 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 22:44:12 INFO - Using env: {'DISPLAY': ':0', 22:44:12 INFO - 'HOME': '/home/cltbld', 22:44:12 INFO - 'LANG': 'en_US.UTF-8', 22:44:12 INFO - 'LANGUAGE': 'en_US:en', 22:44:12 INFO - 'LOGNAME': 'cltbld', 22:44:12 INFO - 'MAIL': '/var/mail/cltbld', 22:44:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:12 INFO - 'MOZ_NO_REMOTE': '1', 22:44:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:12 INFO - 'NO_EM_RESTART': '1', 22:44:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:44:12 INFO - 'PWD': '/builds/slave/test-pgo', 22:44:12 INFO - 'SHELL': '/bin/bash', 22:44:12 INFO - 'SHLVL': '1', 22:44:12 INFO - 'TERM': 'linux', 22:44:12 INFO - 'TMOUT': '86400', 22:44:12 INFO - 'USER': 'cltbld', 22:44:12 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', 22:44:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:12 INFO - '_': '/tools/buildbot/bin/python'} 22:44:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:13 INFO - Downloading/unpacking jsonschema 22:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:44:14 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 22:44:14 INFO - Downloading/unpacking functools32 (from jsonschema) 22:44:14 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 22:44:14 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 22:44:14 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 22:44:14 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 22:44:14 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 22:44:14 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 22:44:15 INFO - Downloading functools32-3.2.3-2.tar.gz 22:44:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:44:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:44:15 INFO - warning: no files found matching '*.txt' 22:44:15 INFO - no previously-included directories found matching 'build' 22:44:15 INFO - no previously-included directories found matching 'dist' 22:44:15 INFO - no previously-included directories found matching '.git*' 22:44:15 INFO - Installing collected packages: jsonschema, functools32 22:44:15 INFO - Running setup.py install for functools32 22:44:15 INFO - warning: no files found matching '*.txt' 22:44:15 INFO - no previously-included directories found matching 'build' 22:44:15 INFO - no previously-included directories found matching 'dist' 22:44:15 INFO - no previously-included directories found matching '.git*' 22:44:15 INFO - Successfully installed jsonschema functools32 22:44:15 INFO - Cleaning up... 22:44:15 INFO - Return code: 0 22:44:15 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:44:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:44:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:44:15 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe03a4e4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22dd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ad630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243e840>, '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 0x23ab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23abb60>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', '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 22:44:15 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 22:44:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 22:44:15 INFO - Using env: {'DISPLAY': ':0', 22:44:15 INFO - 'HOME': '/home/cltbld', 22:44:15 INFO - 'LANG': 'en_US.UTF-8', 22:44:15 INFO - 'LANGUAGE': 'en_US:en', 22:44:15 INFO - 'LOGNAME': 'cltbld', 22:44:15 INFO - 'MAIL': '/var/mail/cltbld', 22:44:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:15 INFO - 'MOZ_NO_REMOTE': '1', 22:44:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:15 INFO - 'NO_EM_RESTART': '1', 22:44:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:44:15 INFO - 'PWD': '/builds/slave/test-pgo', 22:44:15 INFO - 'SHELL': '/bin/bash', 22:44:15 INFO - 'SHLVL': '1', 22:44:15 INFO - 'TERM': 'linux', 22:44:15 INFO - 'TMOUT': '86400', 22:44:15 INFO - 'USER': 'cltbld', 22:44:15 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', 22:44:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:15 INFO - '_': '/tools/buildbot/bin/python'} 22:44:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:44:15 INFO - Downloading/unpacking flake8 22:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:44:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 22:44:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:44:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 22:44:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:17 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 22:44:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:44:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:44:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:44:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 22:44:17 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:44:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:44:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:44:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:44:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:44:17 INFO - no previously-included directories found matching 'docs/_build' 22:44:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:44:17 INFO - Running setup.py install for pep8 22:44:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:44:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:44:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:44:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:44:18 INFO - no previously-included directories found matching 'docs/_build' 22:44:18 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:44:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:44:18 INFO - Cleaning up... 22:44:18 INFO - Return code: 0 22:44:18 INFO - Running post-action listener: _resource_record_post_action 22:44:18 INFO - Running post-action listener: _start_resource_monitoring 22:44:18 INFO - Starting resource monitoring. 22:44:18 INFO - ##### 22:44:18 INFO - ##### Running install step. 22:44:18 INFO - ##### 22:44:18 INFO - Running pre-action listener: _resource_record_pre_action 22:44:18 INFO - Running main action method: install 22:44:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:44:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:44:18 INFO - Reading from file tmpfile_stdout 22:44:18 INFO - Detecting whether we're running mozinstall >=1.0... 22:44:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:44:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:44:18 INFO - Reading from file tmpfile_stdout 22:44:18 INFO - Output received: 22:44:18 INFO - Usage: mozinstall [options] installer 22:44:18 INFO - Options: 22:44:18 INFO - -h, --help show this help message and exit 22:44:18 INFO - -d DEST, --destination=DEST 22:44:18 INFO - Directory to install application into. [default: 22:44:18 INFO - "/builds/slave/test-pgo"] 22:44:18 INFO - --app=APP Application being installed. [default: firefox] 22:44:18 INFO - mkdir: /builds/slave/test-pgo/build/application 22:44:18 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:44:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:44:34 INFO - Reading from file tmpfile_stdout 22:44:34 INFO - Output received: 22:44:34 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:44:34 INFO - Running post-action listener: _resource_record_post_action 22:44:34 INFO - ##### 22:44:34 INFO - ##### Running run-tests step. 22:44:34 INFO - ##### 22:44:34 INFO - Running pre-action listener: _resource_record_pre_action 22:44:34 INFO - Running main action method: run_tests 22:44:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:44:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:44:34 INFO - Python 2.7.3 22:44:34 INFO - Return code: 0 22:44:34 INFO - grabbing minidump binary from tooltool 22:44:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:44:34 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 0x243e840>, '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 0x23ab6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23abb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:44:34 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 22:44:34 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 22:44:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:44:34 INFO - Return code: 0 22:44:34 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:44:34 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:44:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:44:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:44:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:44:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:44:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:44:35 INFO - Return code: 0 22:44:35 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/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 22:44:35 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/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 22:44:35 INFO - Using env: {'DISPLAY': ':0', 22:44:35 INFO - 'HOME': '/home/cltbld', 22:44:35 INFO - 'LANG': 'en_US.UTF-8', 22:44:35 INFO - 'LANGUAGE': 'en_US:en', 22:44:35 INFO - 'LOGNAME': 'cltbld', 22:44:35 INFO - 'MAIL': '/var/mail/cltbld', 22:44:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:44:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:44:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:44:35 INFO - 'MOZ_NO_REMOTE': '1', 22:44:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:44:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:44:35 INFO - 'NO_EM_RESTART': '1', 22:44:35 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:44:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:44:35 INFO - 'PWD': '/builds/slave/test-pgo', 22:44:35 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:44:35 INFO - 'SHELL': '/bin/bash', 22:44:35 INFO - 'SHLVL': '1', 22:44:35 INFO - 'TERM': 'linux', 22:44:35 INFO - 'TMOUT': '86400', 22:44:35 INFO - 'USER': 'cltbld', 22:44:35 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928', 22:44:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:44:35 INFO - '_': '/tools/buildbot/bin/python'} 22:44:35 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/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 22:44:35 INFO - mozversion application_buildid: 20160104203144 22:44:35 INFO - mozversion application_changeset: e5c4bd0666192024af9ea7842c0b710c1ac749ba 22:44:35 INFO - mozversion application_display_name: Nightly 22:44:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:44:35 INFO - mozversion application_name: Firefox 22:44:35 INFO - mozversion application_remotingname: firefox 22:44:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:44:35 INFO - mozversion application_vendor: Mozilla 22:44:35 INFO - mozversion application_version: 46.0a1 22:44:35 INFO - mozversion platform_buildid: 20160104203144 22:44:35 INFO - mozversion platform_changeset: e5c4bd0666192024af9ea7842c0b710c1ac749ba 22:44:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:44:35 INFO - mozversion platform_version: 46.0a1 22:44:35 INFO - using testdate: 1451976275 22:44:35 INFO - actual date: 1451976275 22:44:35 INFO - starting webserver on 'localhost:59358' 22:44:35 INFO - SUITE-START | Running 3 tests 22:44:35 INFO - TEST-START | dromaeo_css 22:44:35 INFO - operating with platform_type : linux_ 22:44:35 INFO - Initialising browser for dromaeo_css test... 22:44:35 INFO - TEST-INFO | started process 5096 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvKJ2Rh/profile http://localhost:59358/getInfo.html) 22:44:41 INFO - PROCESS | 5096 | __metrics Screen width/height:1600/1200 22:44:41 INFO - PROCESS | 5096 | colorDepth:24 22:44:41 INFO - PROCESS | 5096 | Browser inner width/height: 1024/697 22:44:41 INFO - PROCESS | 5096 | __metrics 22:44:41 INFO - PROCESS | 5096 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:44:42 INFO - TEST-INFO | 5096: exit 0 22:44:42 INFO - Browser initialized. 22:44:42 INFO - Running cycle 1/1 for dromaeo_css test... 22:44:42 INFO - TEST-INFO | started process 5229 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvKJ2Rh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:44:54 INFO - PROCESS | 5229 | RSS: Main: 150003712 22:44:54 INFO - PROCESS | 5229 | 22:45:44 INFO - PROCESS | 5229 | 1451976344288 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] 22:47:53 INFO - PROCESS | 5229 | Cycle 1(1): loaded http://localhost:59358/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59358/tests/dromaeo/cssquery-ext.html) 22:47:54 INFO - PROCESS | 5229 | RSS: Main: 158183424 22:47:54 INFO - PROCESS | 5229 | 22:50:56 INFO - PROCESS | 5229 | Cycle 1(1): loaded http://localhost:59358/tests/dromaeo/cssquery-ext.html (next: http://localhost:59358/tests/dromaeo/cssquery-jquery.html) 22:50:56 INFO - PROCESS | 5229 | RSS: Main: 151502848 22:50:56 INFO - PROCESS | 5229 | 22:53:58 INFO - PROCESS | 5229 | Cycle 1(1): loaded http://localhost:59358/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59358/tests/dromaeo/cssquery-mootools.html) 22:53:59 INFO - PROCESS | 5229 | RSS: Main: 153530368 22:53:59 INFO - PROCESS | 5229 | 22:57:00 INFO - PROCESS | 5229 | Cycle 1(1): loaded http://localhost:59358/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59358/tests/dromaeo/cssquery-prototype.html) 22:57:01 INFO - PROCESS | 5229 | RSS: Main: 152240128 22:57:01 INFO - PROCESS | 5229 | 23:00:03 INFO - PROCESS | 5229 | Cycle 1(1): loaded http://localhost:59358/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59358/tests/dromaeo/cssquery-yui.html) 23:00:04 INFO - PROCESS | 5229 | RSS: Main: 152961024 23:00:04 INFO - PROCESS | 5229 | 23:03:07 INFO - PROCESS | 5229 | Cycle 1(1): loaded http://localhost:59358/tests/dromaeo/cssquery-yui.html (next: http://localhost:59358/tests/dromaeo/cssquery-dojo.html) 23:03:07 INFO - PROCESS | 5229 | RSS: Main: 155271168 23:03:07 INFO - PROCESS | 5229 | 23:03:07 INFO - PROCESS | 5229 | __start_tp_report 23:03:07 INFO - PROCESS | 5229 | _x_x_mozilla_page_load 23:03:07 INFO - PROCESS | 5229 | _x_x_mozilla_page_load_details 23:03:07 INFO - PROCESS | 5229 | |i|pagename|runs| 23:03:07 INFO - PROCESS | 5229 | |0;dojo.html;3137.639171495278;3168.334649723558;3193.1538142392255;3221.5167724841276;3225.6451790303063;5283.8150664726745;5365.517103460693;5372.462753724625;5396.541293990011;5402.135658294674;5364.7317634118335;5369.785208591652;5453.400125986138;5503.724813759316;5535.03136951033;4951.702897826133;4977.800887964477;4982.277569752384;5053.494650534935;5077.466865979074;4995.275685025669;5021;5062;5080.466551012128;5082.161443361841;4837.612990960714;4843.176659967814;4942.03630292095;4976.2286845539;4981.352424184869;4871.488493708145;4900.852974410774;4931.65478416511;4945.159322915077;4960.181570040939;4781.258904869751;4900.191468407708;4930.5069493050405;4973.154563724175;5013;5187.325647665779;5242.8689282767855;5250.553702935217;5292.259083728281;5294.576433885319;5747.051736463479;5778.913316300259;5783.5951483396175;5783.739731712041;5799.3910639382675;5703.65778053314;5807.767689292423;5814.534837213013;5822.475977162076;5825.242718446617;5406.783728650849;5408.594355423359;5411.9729401353525;5413.350397952231;5415.6479828811;5822.155787410802;5877.676727779927;5920.31916329619;5921.526277897758;5985.072313791369;5706.343770466367;5748.051571490657;5751.424857514299;5757.0788673811985;5763.366029736726;5674.574406919498;5801.9129713054335;5827.300723913073;5838.299404071454;5844.503217226584;5748.367679555246;5751.971240143856;5831.854203644858;5834.387389324144;5853.824385268449;5742.856428589319;5749.051406517878;5773.88452230953;5786.826395208151;5787.247657804459;4415.249407600716;4450.643948484114;4486.910261794811;4493.326001099861;4543.295789152687;3950.9012274692786;3986.5216174059296;4022.738521996061;4051.088505086391;4060.634542891154;5364.517193452608;5413.160960051198;5451.182322651634;5455.236266922634;5455.918161227505;5782.826515204551;5806.738696758572;5818.156367326798;5820.214271073435;5862.736176872051;5371.301730774974;5372.247885296062;5400.91898621521;5482.23248745176;5517.972410138004;4922.261660750916;4928.28539861718;4934.9753251233515;4945.480724523945;4968.577670897942;5963.761449541969;5973.372795856372;5981.611195272293;5986.850328741816;5988.880222395528;5727.599068065196;5796.739146738491;5827.271591051119;5828.533717302521;5842.38654941225;5934;5982.880342393215;5990.520758339235;6008.459238668541;6013.87972240544;5608.46719561641;5650.0677388232125;5686.516646085129;5697.772089116389;5743.483086522233;5731.828045158485;5812.564057695605;5824.155497452761;5840.123981402823;5884.264466941632;5669.943300566942;5685.346185188756;5687.573431992534;5691.914621280601;5695.943040569541;5589.441055894378;5625;5673.801416950387;5688.459596338341;5692.914606280826;5551.361593416647;5556.749946252347;5574.86062848432;5603.411641777555;5635.182898479616;5640.210370548209;5684.374718781013;5684.488396044376;5685.232493613475;5690.715464226855;5461.726913654222;5539.335279766454;5544;5567.164925261243;5599.720013999366 23:03:07 INFO - PROCESS | 5229 | |1;ext.html;536.1368197202506;541.4774742373609;561.4077148608219;562.13150682196;571.3515160293068;35466.64533354666;36239.81880090599;36453.635463645354;36507.087322816944;36539.634603653954;39362.40956385656;39862.402063969064;40088.19823603526;40124.19751604966;40309.79845100778;8484.575771211461;8579.742607721779;8602.612882420275;8633;8665.220130188281;8497.490150590984;8516.957415212915;8520.40357174998;8751.212390884819;8773;8706.042335343107;8786.165314295164;8803.867941980876;8832.249258813008;8836.116388361144;8696.086910874394;8697.95651021744;8700.608472618684;8789.824203515926;8792.956035219815;8574.657013719443;8699.260562852101;8733.825323493558;8737.126287371211;8772.517511536864;38945.221095578214;39440.40839387412;39503.40744888829;39508.604913951065;39601.40597891034;2822.816516926414;3194.648588655246;3378.4256676365076;3704.4072948328408;4043.7573745575064;26074.34053949323;26127;26306.605400919;26706.19881403561;27543.862280688667;3072.800267982574;3099.318150006995;3128.7184153426074;3185.442547554192;3247.0745837436452;216280;217815;217847;217986;218551;53383.46616533863;54467.18299225515;54822.72588637031;54954.725226373615;66851.66574167098;59117;59278.40721592815;59394.70302648459;59400;59616;14147.929260353632;14487.348069336906;14497.855021449861;14499.420023199165;14512.564623061326;10419.322744021614;10556.049955504042;10605.946970265099;10610.787784244272;10621.89378106209;19896.801031989784;20178.486613504047;20235.696464553042;20288.898555507127;20364.592708145756;7452.552846829208;7625.961870190614;7727.65225564851;7776.65005074773;7828.7266336475295;918.4213945214472;952.4428209497383;974.2546951582045;998.9511013436008;1134.2627292260097;27777.44445111127;28490.860365585144;28535.28661783472;28600.284992875346;31718.04845854628;982.9262805289632;1001.4141727089734;1045.6862941117633;1076.7039064257392;1078.6710053433778;13837.238951857544;13895.930520347334;13949.58151255464;14002.299885005912;14185.645358865904;326689;331033.75875463116;332236;333545;333734;51504.48495515072;52010.219846702326;52183.47816521862;52191.47808521866;52218.47781522212;1339.4709089909627;1345;1355.2275203134118;1374.883134933542;1485.4800819713014;25828.19202655796;26161;26241;26345.60481592816;26471.735282647696;43776.781116094215;43979.78010109929;43999.12001759883;44330.335044975;44383.77808110939;296850;302176;302544;303135;303697;29865.5520167202;32154.19614509656;32416.83791581027;32699.673003270615;32781.34437311288;38894.2221155581;42037;42321.576784231765;42855.35716964186;43424.13151736884;32058;32428.675713242566;32718.83640581782;32962.67037329692;33343.83328083344;32498.350032998736;32580.185495361857;32737.836310818293;32826.17934551655;32947.67052329542;32108.924371828198;32378.514322285657;32556.37218139036;32877;32987.67012329846;30360.54459183158;31465.685343146277;32237.838810805795;32376.83811580927;32414.351712965137;24276.271711848673;24680.382990425383;24745.25764227076;24899.751002489742;25286.24141275765 23:03:07 INFO - PROCESS | 5229 | |2;jquery.html;360.533109623038;361.29727679663057;364.81941438987707;366.7799320407756;367.05666437256247;16088.115153666544;16897.49307520775;17389.739153912702;17551.12244387782;18042.548936276566;15886;16022.19889005551;16077.919610401961;16459.67080658386;16509.66980660389;4940.678855874366;5082.0598189334905;5083.906960003598;5098.770555325019;5122.513361230677;5042.672226305297;5070.518300761421;5074.771635276403;5091.389033316007;5201.427842937273;4953.900921981558;5158.3552055993005;5163.561097306733;5434.972825135888;5466.753996070166;5115.155999260118;5136.126858434075;5137.537621614073;5139.4346621871755;5415.810446634388;4998.875028124289;5004.249362595603;5004.374453193351;5011.273365362039;5025.396952365703;18969.525761855926;19807.60384792296;20625.896870515553;20631.793682063286;20713.27503537369;1937.82559569638;1969.7045443183495;2072.492239401341;2156.7735387784214;2228.699125618053;6755.054292399068;9106.68126615572;9630.133288004043;11153.940375664299;12493.063020273516;1755.2276998120785;1773.1134432783608;1857.6284743051308;1872.4850666066804;1941.8446524278165;56243;59580;59602.701986490225;60113.398866011215;60947.39052609461;10256.487175641189;10407.271490995558;10454.42500662471;10456.163506919429;10492.160627149962;13397.397117129753;13560.11859229147;13583.728325433436;13597.728045439037;13620.795688064687;7204.459665525106;7277.345038946521;7292.927070729331;7307.926920730724;7349.448791340564;6971.407430368476;7002.929970700329;7011.474139439562;7031.296870312928;7035.085438892911;4429.424174857248;4491.30384790358;4519.367288579601;4542.205114105019;4561.133384656904;1736.0278244183298;1780.5459607799928;1828.8628352873322;1843.3363988963963;1883.4820424383404;849.3120572336427;946.3044662173297;947.8530827721577;959.7264779537799;1009.0716540782498;14416.351264193136;15355.23223838826;15726.370945162294;16463.423780167635;16838.242279097223;917.8806755121791;943.6649989253854;944.5749412764284;969.147150507563;985.4085651672498;9373.297002724823;9406.529673516297;9577.23382129428;9605.991370906095;9796.216302695768;512790.9767218688;525582;526241;526543;546950;72571;73752.63123684347;74833;76939.61530192425;77726.2227377719;1079.1097344690504;1084.3168803653805;1139.9373034483017;1155.2952698853692;1155.6186458468685;14957.775633365725;15041.473548425753;15177.317020733874;15187.924060379628;15478.767818482507;33233.66766332403;33471.16322091967;34563.82718086393;35003.64996350004;35165.47251791174;45711;45725.77137114293;45927.311090333;48242.51757482521;48776.51223487862;9398.812023759623;9558.28312876551;9938.155256803253;9952;10011.24915631316;11761.764764704829;11826.881731182579;17111.401100961408;17422.651546969242;17652.823471765118;10885.945570272099;13374.598762037154;13754.724905502035;13764.17414955106;14259.64350891236;13242.470301187845;13459.259740714355;13576.728465430439;13729.244891531062;13860.930695346458;13987.790183147057;14004.649883752987;14120.2939853009;14161.575152745021;14233.786493202817;8847.55762211874;8984;9007.63969441215;9015.467370547154;9411.4823684698;10064.647737329158;11288.774224515628;13844;13890.374933127832;14454.060486068372 23:03:07 INFO - PROCESS | 5229 | |3;mootools.html;1455.2141843404563;1483.3176738700195;1511.984880151199;1541.7995660564125;1582.3037863340137;7541.736039238628;7691.307782299592;7698.384129269659;7791.688332466709;7887.960560197191;7865.8033549161155;7939.841203175933;7943.165967573408;7974.681012759483;7979.960100199505;2234.1175235781857;2262.4343914021497;2272.091163534583;2278.236790675126;2278.3620586235797;2269.977300226993;2294.403455101669;2363.078399424226;2366.9408264793433;2367.7868991790733;1984.3650031989769;2017.788132246115;2238.9888050559807;2262.4230821140586;2298.8965496552696;2239.5632851593946;2241.3388050525136;2248.336740661509;2249.4376405898524;2252.4594097416666;2225.8887055647315;2270.262164796448;2277.9886100569556;2288.725352957639;2293.048384920256;7791.649375778104;7855.253750893656;7858.489198202098;7864.921350786476;7874.724384646567;4563.429571303587;4633.235516139833;4690.742009189493;4721.24460086388;4723.338732577442;3004.2939909121337;3028.6971302869756;3029.182120827364;3035.347400308944;3042.574039634453;947.947862867542;971.3686104032436;974.2060220919998;976.5556671714353;1052.8420736889452;10870.130389568816;10939.781204375868;10994.175436842188;10999.725006874893;11025.61410350642;4043.4541336919137;4071.6131967463043;4094.9181016379507;4115.650169735546;4222.852200172979;8786.86819697705;8815.030346661862;8816.250618697355;8843.955780221186;8859.689910853089;4544.545545445429;4554.27131658933;4578.725276483422;4580.244259697112;4583.060472603109;4188.643965262926;4197.370394440797;4229.407882896397;4235.97882010588;4245.97877010613;3404.2510647657477;3412.4369479036177;3413.9487907681405;3434.1929646533044;3439.6904278614543;1031.169908223887;1052.936823790575;1065.1638463805875;1067.754416484213;1084.2789544952675;899.0649724286799;924.1867156901883;1048.7116043088213;1073.9958139139928;1132.5752842683994;6970.651467426608;6982.581045137308;7008.983697363854;7068.823279417953;7073.504854660125;609.3236507476697;616.7132283488199;634.8539835837784;640.3692363022419;768.2164192523707;5299.708516031656;5515.034868898007;5516.613837031449;5517.972410137923;5523.944760552343;9166.404183728037;9226.21577165935;9382.90617093834;9389.530523473799;9491.145796878314;9114.635414583476;9154.954225228832;9167.816643667089;9169.174774270348;9181.816363672822;7176.928230717626;7326.120865496175;7351.926480735231;7404.851902961911;7429.108506979197;7312.41500679955;7339.9633001834645;7363.079615048119;7403.222661620668;7416.7774966751085;8266.669333226604;8423.284020858297;8444.197801208875;8463.111373305714;8522;8332.500049996777;8537.762024506535;8555.31557475388;8608.956955215184;8634.78413039679;6850.0409942607075;6898.413634841095;7031.191412987572;7194.100737407824;7194.4244460442;7641.388688904985;7696.037995250594;7777.300042996158;7787.922120778946;7797.337226335598;7090.4682148840075;7180.3537681608905;7250.709971601077;7280.3083707047745;7402.037735094404;6784.13088585801;6891.517593768388;6933.7226510939;6945.617991010543;7034.859302814018;7177.354038136593;7179.066721326194;7189.892151617625;7198.280171982759;7220.3140701633265;6092.969535152296;6129.969350153221;6131.110988906673;6152.569320147547;6196.070589411444;6600.471962242913;6637.402633762985;6682.164729408824;6722.932770672426;6726.058351830846 23:03:07 INFO - PROCESS | 5229 | |4;prototype.html;343.0976531721572;344.72766514453565;347.0185242266657;352.31474781549895;353.05909750514877;6152.5385596080305;6174.166487524189;6201.224846894138;6217.160683307752;6330.145430366899;6154.753809847601;6187.721552530135;6217.347178546255;6253;6256;4704.1062198182235;4706.694064885789;4713.316569097479;4715.269133284346;4717.056588682261;4713.481517033124;4720.197566413718;4723.48041715411;4732.361131247272;4740.549647783455;4542.114287713897;4563.543645635426;4619.976900115495;4640.257558790594;4688.648351373644;4582.793774280165;4589.495155532889;4597.586217240464;4616.884577885546;4619.122366750306;3974.364101743707;3986.920261594752;4034.636882680573;4040.4141399497203;4052.0680243543857;5869.325027621793;5897.557683173736;5899.2920849497905;5905.320888097838;5920.171176035358;5292.153255479144;5425.321834770653;5460.071787796044;5493.670379777226;5514.889702205934;6565.835854103638;6570.770023049218;6593.406593406617;6601.141851559315;6602.5708328958945;4537.9773101134615;4540.477845047829;4543.613792827614;4547.15877562652;4548.385967894325;6748.460123190133;6870.244273129952;6909.550879192887;6933.375996160319;6946.409555187815;4657.138429390574;4657.6273898088075;4662.603678687349;4665.766711664471;4668.626509879202;4706.670533062721;4707;4712.976435117803;4716.457607375196;4725.385699858996;5461.453854614586;5474.698891560923;5478.91781623276;5479.0959491684225;5485.835424937259;6507.609543427409;6666.500012498985;6668.499862510234;6674.733010679518;6675.065490831287;1639.1148779658852;1659.7842280503457;1659.7925259342583;1664.3924967387059;1665.775120358736;1097.067492631257;1097.6048622495896;1105.5080489182237;1116.9329840209614;1123.4270522033657;6299.748010079637;6301.0863424804065;6301.684915754194;6307.369263073656;6320.273168585672;6829.180498340231;6842.692078856463;6852.897206541906;6856.24581296057;6863.6568171591225;6163.260408750889;6292.370762923671;6302.873942521124;6330.39861213184;6367.808965731036;3676.4117741161285;3706.388445906395;3708.35103856824;3727.366347720894;3732.0856390184035;7147.499675022803;7170.533915295593;7212;7216.242294559101;7235.565866048054;6949.791506254821;7015.193252775894;7060.823479412953;7062.6821793019435;7095.361417472453;7208.171060328024;7231.783046508614;7239.20368759436;7239.9999999998945;7258.056452661121;6842.7683017055415;6855.348741869514;6894;6908.758193463204;6911.688973996082;6738.46092312604;6808.693608787517;6863.450923926173;6878.140232470942;6879.724811007503;7239.203687594466;7257;7257.2742725727;7258.709651613876;7261.564306141437;4629.88425289357;4632.305154226893;4661.091087238092;4664.580187783115;4665.533446655443;6731.293214212633;6915.965420173068;6941.305869413019;6942.500699747986;6949.409300209539;6742.089817874524;6744.629045402354;6745.291744366771;6759.188897332351;6762.154730658668;6678.332166783282;6711.194656641039;6713.765018224339;6716.227633822173;6725.4283385910785;6399.584027038228;6606.43845273138;6615.867682646224;6616.7022483987375;6632.336766323329;6708.228553716385;6746.224184218681;6748.392644662004;6765.42493888025;6774.390304872585;6435.742570297136;6513.1532900722605;6535.509836762167;6608.570442921195;6616.437602803816 23:03:07 INFO - PROCESS | 5229 | |5;yui.html;754.6981207516995;765.7243392378739;771.4021633234242;783.1385475976426;823.8764185372195;12820.230786152826;13062.542811001616;13086.214827110369;13101.08292419531;13114.34428278587;12617.4322155503;12647.367631618405;12720.427580758866;12726.618201453948;12727.363631818418;830.489249111795;831.1605278668528;846.7925358287229;846.8602680557732;848.1942154952819;835.8620827563444;844.4384484317952;844.7676888855583;845.8266055458616;848.0755975986174;851.2551517422255;852.8805967164602;855.6149732620314;864.2437866866492;880.8326417980563;858.4977787994031;860.3934226370394;864.2351518905782;883.8983516895511;889.2263730554427;646.7639311651213;647.8769033883547;648.3710800523485;648.7469886744126;648.915640966676;14180.85819141816;14288.142711437244;14324.856751432457;14326.426942922271;14335.56993290203;11535.077193824558;11946.581869634521;12306.81539776904;12312.199707019015;12734.61796146117;9989.700308990741;10057.195424366033;10240.719286258905;10320;10702.51838667254;3525.4006818840603;3609.8375573099274;3609.9531135970537;3622.7826330420257;3670.5595328560476;48943;48947;49066.50933490655;49220.50779492195;49687.50312496901;9707.854382184272;10027.097561219525;10076.848847267296;10274.126699230499;10575.418351990715;17398.826011739973;17468.91265543664;17506.299748009937;17508.299668013136;17520;7337.19290878003;7398.926010739824;7498.100227972678;7608.391328693691;7623.428242881695;4159.584041595816;4176.164767046542;4242.045539753531;4299.505556860939;4416.889577760582;3039.8024128432025;3087.320789426323;3092.969070309313;3095.92260193497;3096.442640324718;535.7776522743096;536.0592160757845;544.727636181909;550.4083110656061;555.3280530557989;512.456795796457;530.9601779866525;536.3831593667314;586.3403670870271;664.6244871647503;7844.9607751960875;8219.712310069119;8235.794105147419;8260.173982601691;8884.156005179497;595.3332267860025;610.3133974278936;655.2137435077925;678.260695841535;729.824842037907;3723.4414837774552;3768.2651882883124;3825.9617403825605;3852.325842977468;3870.322693528621;49624;49880.750596246784;50752.492475075516;51098.23352649713;52286.21570676443;47105.822354441414;47715.28427073597;47728.28407573889;47824.52175478201;48698;42866.57133428626;43323.56676433259;43403.782981085526;44469;44957.77521112439;7429.257074292527;7683.538987660758;7716;7723.189065148079;8017.559034253172;32748.83625581857;32801.34397312088;33237;33767.49348759722;34083;42170.78914605407;42418.15163696647;42661.57338426576;42762;43499.56500434955;9824.557894894604;10056.29605927578;10138.23963202748;10408.411159122992;10528;10599.258051936291;10960.506777194885;10982.505787239754;11541.192116551762;11558.884411155781;9223.400478968846;9383.155516003593;9533.666321678707;10053.04496072872;10078.79842403133;9259.953700231456;9527.714168574954;9529.761755955878;9615.375000624937;9729.513524323896;9909.65316213929;10058.195344372287;10132.392056476636;10236;10344;9124.95437522808;9173.816523669622;9256;9257.259419246579;9264.861027084464;8355.791105222417;8774.912250877665;8782.253508451598;8849.734507964771;8853.778655533662 23:03:07 INFO - PROCESS | 5229 | __end_tp_report 23:03:07 INFO - PROCESS | 5229 | __start_cc_report 23:03:07 INFO - PROCESS | 5229 | _x_x_mozilla_cycle_collect,313 23:03:07 INFO - PROCESS | 5229 | __end_cc_report 23:03:07 INFO - PROCESS | 5229 | __startTimestamp1451977387277__endTimestamp 23:03:07 INFO - PROCESS | 5229 | 23:03:07 INFO - PROCESS | 5229 | ------- Summary: start ------- 23:03:07 INFO - PROCESS | 5229 | Number of tests: 6 23:03:07 INFO - PROCESS | 5229 | 23:03:07 INFO - PROCESS | 5229 | [#0] dojo.html Cycles:165 Average:5381.43 Median:5589.44 stddev:594.42 (10.6%) stddev-sans-first:569.58 23:03:07 INFO - PROCESS | 5229 | Values: 3137.6 3168.3 3193.2 3221.5 3225.6 5283.8 5365.5 5372.5 5396.5 5402.1 5364.7 5369.8 5453.4 5503.7 5535.0 4951.7 4977.8 4982.3 5053.5 5077.5 4995.3 5021.0 5062.0 5080.5 5082.2 4837.6 4843.2 4942.0 4976.2 4981.4 4871.5 4900.9 4931.7 4945.2 4960.2 4781.3 4900.2 4930.5 4973.2 5013.0 5187.3 5242.9 5250.6 5292.3 5294.6 5747.1 5778.9 5783.6 5783.7 5799.4 5703.7 5807.8 5814.5 5822.5 5825.2 5406.8 5408.6 5412.0 5413.4 5415.6 5822.2 5877.7 5920.3 5921.5 5985.1 5706.3 5748.1 5751.4 5757.1 5763.4 5674.6 5801.9 5827.3 5838.3 5844.5 5748.4 5752.0 5831.9 5834.4 5853.8 5742.9 5749.1 5773.9 5786.8 5787.2 4415.2 4450.6 4486.9 4493.3 4543.3 3950.9 3986.5 4022.7 4051.1 4060.6 5364.5 5413.2 5451.2 5455.2 5455.9 5782.8 5806.7 5818.2 5820.2 5862.7 5371.3 5372.2 5400.9 5482.2 5518.0 4922.3 4928.3 4935.0 4945.5 4968.6 5963.8 5973.4 5981.6 5986.9 5988.9 5727.6 5796.7 5827.3 5828.5 5842.4 5934.0 5982.9 5990.5 6008.5 6013.9 5608.5 5650.1 5686.5 5697.8 5743.5 5731.8 5812.6 5824.2 5840.1 5884.3 5669.9 5685.3 5687.6 5691.9 5695.9 5589.4 5625.0 5673.8 5688.5 5692.9 5551.4 5556.7 5574.9 5603.4 5635.2 5640.2 5684.4 5684.5 5685.2 5690.7 5461.7 5539.3 5544.0 5567.2 5599.7 23:03:07 INFO - PROCESS | 5229 | 23:03:07 INFO - PROCESS | 5229 | [#1] ext.html Cycles:180 Average:44717.61 Median:32975.17 stddev:75378.88 (228.6%) stddev-sans-first:75517.34 23:03:07 INFO - PROCESS | 5229 | Values: 536.1 541.5 561.4 562.1 571.4 35466.6 36239.8 36453.6 36507.1 36539.6 39362.4 39862.4 40088.2 40124.2 40309.8 8484.6 8579.7 8602.6 8633.0 8665.2 8497.5 8517.0 8520.4 8751.2 8773.0 8706.0 8786.2 8803.9 8832.2 8836.1 8696.1 8698.0 8700.6 8789.8 8793.0 8574.7 8699.3 8733.8 8737.1 8772.5 38945.2 39440.4 39503.4 39508.6 39601.4 2822.8 3194.6 3378.4 3704.4 4043.8 26074.3 26127.0 26306.6 26706.2 27543.9 3072.8 3099.3 3128.7 3185.4 3247.1 216280.0 217815.0 217847.0 217986.0 218551.0 53383.5 54467.2 54822.7 54954.7 66851.7 59117.0 59278.4 59394.7 59400.0 59616.0 14147.9 14487.3 14497.9 14499.4 14512.6 10419.3 10556.0 10605.9 10610.8 10621.9 19896.8 20178.5 20235.7 20288.9 20364.6 7452.6 7626.0 7727.7 7776.7 7828.7 918.4 952.4 974.3 999.0 1134.3 27777.4 28490.9 28535.3 28600.3 31718.0 982.9 1001.4 1045.7 1076.7 1078.7 13837.2 13895.9 13949.6 14002.3 14185.6 326689.0 331033.8 332236.0 333545.0 333734.0 51504.5 52010.2 52183.5 52191.5 52218.5 1339.5 1345.0 1355.2 1374.9 1485.5 25828.2 26161.0 26241.0 26345.6 26471.7 43776.8 43979.8 43999.1 44330.3 44383.8 296850.0 302176.0 302544.0 303135.0 303697.0 29865.6 32154.2 32416.8 32699.7 32781.3 38894.2 42037.0 42321.6 42855.4 43424.1 32058.0 32428.7 32718.8 32962.7 33343.8 32498.4 32580.2 32737.8 32826.2 32947.7 32108.9 32378.5 32556.4 32877.0 32987.7 30360.5 31465.7 32237.8 32376.8 32414.4 24276.3 24680.4 24745.3 24899.8 25286.2 23:03:07 INFO - PROCESS | 5229 | 23:03:07 INFO - PROCESS | 5229 | [#2] jquery.html Cycles:180 Average:28114.90 Median:363.06 stddev:86187.05 (23739.2%) stddev-sans-first:86403.63 23:03:07 INFO - PROCESS | 5229 | Values: 360.5 361.3 364.8 366.8 367.1 16088.1 16897.5 17389.7 17551.1 18042.5 15886.0 16022.2 16077.9 16459.7 16509.7 4940.7 5082.1 5083.9 5098.8 5122.5 5042.7 5070.5 5074.8 5091.4 5201.4 4953.9 5158.4 5163.6 5435.0 5466.8 5115.2 5136.1 5137.5 5139.4 5415.8 4998.9 5004.2 5004.4 5011.3 5025.4 18969.5 19807.6 20625.9 20631.8 20713.3 1937.8 1969.7 2072.5 2156.8 2228.7 6755.1 9106.7 9630.1 11153.9 12493.1 1755.2 1773.1 1857.6 1872.5 1941.8 56243.0 59580.0 59602.7 60113.4 60947.4 10256.5 10407.3 10454.4 10456.2 10492.2 13397.4 13560.1 13583.7 13597.7 13620.8 7204.5 7277.3 7292.9 7307.9 7349.4 6971.4 7002.9 7011.5 7031.3 7035.1 4429.4 4491.3 4519.4 4542.2 4561.1 1736.0 1780.5 1828.9 1843.3 1883.5 849.3 946.3 947.9 959.7 1009.1 14416.4 15355.2 15726.4 16463.4 16838.2 917.9 943.7 944.6 969.1 985.4 9373.3 9406.5 9577.2 9606.0 9796.2 512791.0 525582.0 526241.0 526543.0 546950.0 72571.0 73752.6 74833.0 76939.6 77726.2 1079.1 1084.3 1139.9 1155.3 1155.6 14957.8 15041.5 15177.3 15187.9 15478.8 33233.7 33471.2 34563.8 35003.6 35165.5 45711.0 45725.8 45927.3 48242.5 48776.5 9398.8 9558.3 9938.2 9952.0 10011.2 11761.8 11826.9 17111.4 17422.7 17652.8 10885.9 13374.6 13754.7 13764.2 14259.6 13242.5 13459.3 13576.7 13729.2 13860.9 13987.8 14004.6 14120.3 14161.6 14233.8 8847.6 8984.0 9007.6 9015.5 9411.5 10064.6 11288.8 13844.0 13890.4 14454.1 23:03:07 INFO - PROCESS | 5229 | 23:03:07 INFO - PROCESS | 5229 | [#3] mootools.html Cycles:180 Average:5427.95 Median:6702.55 stddev:2881.13 (43.0%) stddev-sans-first:2873.74 23:03:07 INFO - PROCESS | 5229 | Values: 1455.2 1483.3 1512.0 1541.8 1582.3 7541.7 7691.3 7698.4 7791.7 7888.0 7865.8 7939.8 7943.2 7974.7 7980.0 2234.1 2262.4 2272.1 2278.2 2278.4 2270.0 2294.4 2363.1 2366.9 2367.8 1984.4 2017.8 2239.0 2262.4 2298.9 2239.6 2241.3 2248.3 2249.4 2252.5 2225.9 2270.3 2278.0 2288.7 2293.0 7791.6 7855.3 7858.5 7864.9 7874.7 4563.4 4633.2 4690.7 4721.2 4723.3 3004.3 3028.7 3029.2 3035.3 3042.6 947.9 971.4 974.2 976.6 1052.8 10870.1 10939.8 10994.2 10999.7 11025.6 4043.5 4071.6 4094.9 4115.7 4222.9 8786.9 8815.0 8816.3 8844.0 8859.7 4544.5 4554.3 4578.7 4580.2 4583.1 4188.6 4197.4 4229.4 4236.0 4246.0 3404.3 3412.4 3413.9 3434.2 3439.7 1031.2 1052.9 1065.2 1067.8 1084.3 899.1 924.2 1048.7 1074.0 1132.6 6970.7 6982.6 7009.0 7068.8 7073.5 609.3 616.7 634.9 640.4 768.2 5299.7 5515.0 5516.6 5518.0 5523.9 9166.4 9226.2 9382.9 9389.5 9491.1 9114.6 9155.0 9167.8 9169.2 9181.8 7176.9 7326.1 7351.9 7404.9 7429.1 7312.4 7340.0 7363.1 7403.2 7416.8 8266.7 8423.3 8444.2 8463.1 8522.0 8332.5 8537.8 8555.3 8609.0 8634.8 6850.0 6898.4 7031.2 7194.1 7194.4 7641.4 7696.0 7777.3 7787.9 7797.3 7090.5 7180.4 7250.7 7280.3 7402.0 6784.1 6891.5 6933.7 6945.6 7034.9 7177.4 7179.1 7189.9 7198.3 7220.3 6093.0 6130.0 6131.1 6152.6 6196.1 6600.5 6637.4 6682.2 6722.9 6726.1 23:03:07 INFO - PROCESS | 5229 | 23:03:07 INFO - PROCESS | 5229 | [#4] prototype.html Cycles:180 Average:5542.08 Median:6296.06 stddev:1706.26 (27.1%) stddev-sans-first:1665.82 23:03:07 INFO - PROCESS | 5229 | Values: 343.1 344.7 347.0 352.3 353.1 6152.5 6174.2 6201.2 6217.2 6330.1 6154.8 6187.7 6217.3 6253.0 6256.0 4704.1 4706.7 4713.3 4715.3 4717.1 4713.5 4720.2 4723.5 4732.4 4740.5 4542.1 4563.5 4620.0 4640.3 4688.6 4582.8 4589.5 4597.6 4616.9 4619.1 3974.4 3986.9 4034.6 4040.4 4052.1 5869.3 5897.6 5899.3 5905.3 5920.2 5292.2 5425.3 5460.1 5493.7 5514.9 6565.8 6570.8 6593.4 6601.1 6602.6 4538.0 4540.5 4543.6 4547.2 4548.4 6748.5 6870.2 6909.6 6933.4 6946.4 4657.1 4657.6 4662.6 4665.8 4668.6 4706.7 4707.0 4713.0 4716.5 4725.4 5461.5 5474.7 5478.9 5479.1 5485.8 6507.6 6666.5 6668.5 6674.7 6675.1 1639.1 1659.8 1659.8 1664.4 1665.8 1097.1 1097.6 1105.5 1116.9 1123.4 6299.7 6301.1 6301.7 6307.4 6320.3 6829.2 6842.7 6852.9 6856.2 6863.7 6163.3 6292.4 6302.9 6330.4 6367.8 3676.4 3706.4 3708.4 3727.4 3732.1 7147.5 7170.5 7212.0 7216.2 7235.6 6949.8 7015.2 7060.8 7062.7 7095.4 7208.2 7231.8 7239.2 7240.0 7258.1 6842.8 6855.3 6894.0 6908.8 6911.7 6738.5 6808.7 6863.5 6878.1 6879.7 7239.2 7257.0 7257.3 7258.7 7261.6 4629.9 4632.3 4661.1 4664.6 4665.5 6731.3 6916.0 6941.3 6942.5 6949.4 6742.1 6744.6 6745.3 6759.2 6762.2 6678.3 6711.2 6713.8 6716.2 6725.4 6399.6 6606.4 6615.9 6616.7 6632.3 6708.2 6746.2 6748.4 6765.4 6774.4 6435.7 6513.2 6535.5 6608.6 6616.4 23:03:07 INFO - PROCESS | 5229 | 23:03:07 INFO - PROCESS | 5229 | [#5] yui.html Cycles:180 Average:13084.74 Median:49143.51 stddev:15029.80 (30.6%) stddev-sans-first:15043.44 23:03:07 INFO - PROCESS | 5229 | Values: 754.7 765.7 771.4 783.1 823.9 12820.2 13062.5 13086.2 13101.1 13114.3 12617.4 12647.4 12720.4 12726.6 12727.4 830.5 831.2 846.8 846.9 848.2 835.9 844.4 844.8 845.8 848.1 851.3 852.9 855.6 864.2 880.8 858.5 860.4 864.2 883.9 889.2 646.8 647.9 648.4 648.7 648.9 14180.9 14288.1 14324.9 14326.4 14335.6 11535.1 11946.6 12306.8 12312.2 12734.6 9989.7 10057.2 10240.7 10320.0 10702.5 3525.4 3609.8 3610.0 3622.8 3670.6 48943.0 48947.0 49066.5 49220.5 49687.5 9707.9 10027.1 10076.8 10274.1 10575.4 17398.8 17468.9 17506.3 17508.3 17520.0 7337.2 7398.9 7498.1 7608.4 7623.4 4159.6 4176.2 4242.0 4299.5 4416.9 3039.8 3087.3 3093.0 3095.9 3096.4 535.8 536.1 544.7 550.4 555.3 512.5 531.0 536.4 586.3 664.6 7845.0 8219.7 8235.8 8260.2 8884.2 595.3 610.3 655.2 678.3 729.8 3723.4 3768.3 3826.0 3852.3 3870.3 49624.0 49880.8 50752.5 51098.2 52286.2 47105.8 47715.3 47728.3 47824.5 48698.0 42866.6 43323.6 43403.8 44469.0 44957.8 7429.3 7683.5 7716.0 7723.2 8017.6 32748.8 32801.3 33237.0 33767.5 34083.0 42170.8 42418.2 42661.6 42762.0 43499.6 9824.6 10056.3 10138.2 10408.4 10528.0 10599.3 10960.5 10982.5 11541.2 11558.9 9223.4 9383.2 9533.7 10053.0 10078.8 9260.0 9527.7 9529.8 9615.4 9729.5 9909.7 10058.2 10132.4 10236.0 10344.0 9125.0 9173.8 9256.0 9257.3 9264.9 8355.8 8774.9 8782.3 8849.7 8853.8 23:03:07 INFO - PROCESS | 5229 | -------- Summary: end -------- 23:03:07 INFO - PROCESS | 5229 | 23:03:08 INFO - TEST-INFO | 5229: exit 0 23:03:08 INFO - TEST-OK | dromaeo_css | took 1112571ms 23:03:08 INFO - TEST-START | kraken 23:03:08 INFO - operating with platform_type : linux_ 23:03:08 INFO - Initialising browser for kraken test... 23:03:08 INFO - TEST-INFO | started process 5473 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9trKuM/profile http://localhost:59358/getInfo.html) 23:03:13 INFO - PROCESS | 5473 | __metrics Screen width/height:1600/1200 23:03:13 INFO - PROCESS | 5473 | colorDepth:24 23:03:13 INFO - PROCESS | 5473 | Browser inner width/height: 1024/697 23:03:13 INFO - PROCESS | 5473 | __metrics 23:03:13 INFO - PROCESS | 5473 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:03:14 INFO - TEST-INFO | 5473: exit 0 23:03:14 INFO - Browser initialized. 23:03:14 INFO - Running cycle 1/1 for kraken test... 23:03:14 INFO - TEST-INFO | started process 5593 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9trKuM/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:03:26 INFO - PROCESS | 5593 | RSS: Main: 150458368 23:03:26 INFO - PROCESS | 5593 | 23:03:28 INFO - PROCESS | 5593 | Cycle 1(1): loaded http://localhost:59358/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59358/tests/kraken/driver.html?testName=audio-beat-detection) 23:03:29 INFO - PROCESS | 5593 | RSS: Main: 150679552 23:03:29 INFO - PROCESS | 5593 | 23:03:32 INFO - PROCESS | 5593 | Cycle 1(1): loaded http://localhost:59358/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59358/tests/kraken/driver.html?testName=audio-dft) 23:03:32 INFO - PROCESS | 5593 | RSS: Main: 151945216 23:03:32 INFO - PROCESS | 5593 | 23:03:35 INFO - PROCESS | 5593 | Cycle 1(1): loaded http://localhost:59358/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59358/tests/kraken/driver.html?testName=audio-fft) 23:03:36 INFO - PROCESS | 5593 | RSS: Main: 146518016 23:03:36 INFO - PROCESS | 5593 | 23:03:38 INFO - PROCESS | 5593 | Cycle 1(1): loaded http://localhost:59358/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59358/tests/kraken/driver.html?testName=audio-oscillator) 23:03:38 INFO - PROCESS | 5593 | RSS: Main: 146477056 23:03:38 INFO - PROCESS | 5593 | 23:03:41 INFO - PROCESS | 5593 | Cycle 1(1): loaded http://localhost:59358/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59358/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:03:41 INFO - PROCESS | 5593 | RSS: Main: 146276352 23:03:41 INFO - PROCESS | 5593 | 23:03:44 INFO - PROCESS | 5593 | Cycle 1(1): loaded http://localhost:59358/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59358/tests/kraken/driver.html?testName=imaging-darkroom) 23:03:45 INFO - PROCESS | 5593 | RSS: Main: 147890176 23:03:45 INFO - PROCESS | 5593 | 23:03:48 INFO - PROCESS | 5593 | Cycle 1(1): loaded http://localhost:59358/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59358/tests/kraken/driver.html?testName=imaging-desaturate) 23:03:49 INFO - PROCESS | 5593 | RSS: Main: 148914176 23:03:49 INFO - PROCESS | 5593 | 23:03:52 INFO - PROCESS | 5593 | Cycle 1(1): loaded http://localhost:59358/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59358/tests/kraken/driver.html?testName=json-parse-financial) 23:03:52 INFO - PROCESS | 5593 | RSS: Main: 147664896 23:03:52 INFO - PROCESS | 5593 | 23:03:54 INFO - PROCESS | 5593 | Cycle 1(1): loaded http://localhost:59358/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59358/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:03:54 INFO - PROCESS | 5593 | RSS: Main: 148905984 23:03:54 INFO - PROCESS | 5593 | 23:03:56 INFO - PROCESS | 5593 | Cycle 1(1): loaded http://localhost:59358/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59358/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:03:57 INFO - PROCESS | 5593 | RSS: Main: 148529152 23:03:57 INFO - PROCESS | 5593 | 23:03:59 INFO - PROCESS | 5593 | Cycle 1(1): loaded http://localhost:59358/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59358/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:04:00 INFO - PROCESS | 5593 | RSS: Main: 148881408 23:04:00 INFO - PROCESS | 5593 | 23:04:02 INFO - PROCESS | 5593 | Cycle 1(1): loaded http://localhost:59358/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:04:03 INFO - PROCESS | 5593 | RSS: Main: 148836352 23:04:03 INFO - PROCESS | 5593 | 23:04:05 INFO - PROCESS | 5593 | Cycle 1(1): loaded http://localhost:59358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:04:06 INFO - PROCESS | 5593 | RSS: Main: 148824064 23:04:06 INFO - PROCESS | 5593 | 23:04:08 INFO - PROCESS | 5593 | Cycle 1(1): loaded http://localhost:59358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59358/tests/kraken/driver.html?testName=ai-astar) 23:04:08 INFO - PROCESS | 5593 | RSS: Main: 148602880 23:04:08 INFO - PROCESS | 5593 | 23:04:08 INFO - PROCESS | 5593 | __start_tp_report 23:04:08 INFO - PROCESS | 5593 | _x_x_mozilla_page_load 23:04:08 INFO - PROCESS | 5593 | _x_x_mozilla_page_load_details 23:04:08 INFO - PROCESS | 5593 | |i|pagename|runs| 23:04:08 INFO - PROCESS | 5593 | |0;ai-astar;113;110;113;112;113;124;113;112;113;112 23:04:08 INFO - PROCESS | 5593 | |1;audio-beat-detection;150;126;155;164;128;152;148;134;163;125 23:04:08 INFO - PROCESS | 5593 | |2;audio-dft;161;162;161;162;164;161;162;164;168;161 23:04:08 INFO - PROCESS | 5593 | |3;audio-fft;72;73;75;71;73;72;74;139;71;70 23:04:08 INFO - PROCESS | 5593 | |4;audio-oscillator;96;96;150;94;98;96;143;97;96;136 23:04:08 INFO - PROCESS | 5593 | |5;imaging-gaussian-blur;111;110;110;110;110;110;110;111;111;109 23:04:08 INFO - PROCESS | 5593 | |6;imaging-darkroom;148;148;150;147;148;149;147;148;147;147 23:04:08 INFO - PROCESS | 5593 | |7;imaging-desaturate;96;96;96;96;97;96;96;97;96;97 23:04:08 INFO - PROCESS | 5593 | |8;json-parse-financial;62;59;59;60;60;64;60;60;59;59 23:04:08 INFO - PROCESS | 5593 | |9;json-stringify-tinderbox;68;68;68;68;68;68;68;67;68;68 23:04:08 INFO - PROCESS | 5593 | |10;stanford-crypto-aes;87;87;93;88;89;88;92;89;88;88 23:04:08 INFO - PROCESS | 5593 | |11;stanford-crypto-ccm;123;117;120;120;121;127;119;129;121;124 23:04:08 INFO - PROCESS | 5593 | |12;stanford-crypto-pbkdf2;146;154;150;153;144;144;155;152;153;147 23:04:08 INFO - PROCESS | 5593 | |13;stanford-crypto-sha256-iterative;72;69;69;71;70;69;73;71;69;76 23:04:08 INFO - PROCESS | 5593 | __end_tp_report 23:04:08 INFO - PROCESS | 5593 | __start_cc_report 23:04:08 INFO - PROCESS | 5593 | _x_x_mozilla_cycle_collect,719 23:04:08 INFO - PROCESS | 5593 | __end_cc_report 23:04:08 INFO - PROCESS | 5593 | __startTimestamp1451977448314__endTimestamp 23:04:08 INFO - PROCESS | 5593 | 23:04:08 INFO - PROCESS | 5593 | ------- Summary: start ------- 23:04:08 INFO - PROCESS | 5593 | Number of tests: 14 23:04:08 INFO - PROCESS | 5593 | 23:04:08 INFO - PROCESS | 5593 | [#0] ai-astar Cycles:10 Average:113.50 Median:113.00 stddev:3.81 (3.4%) stddev-sans-first:4.03 23:04:08 INFO - PROCESS | 5593 | Values: 113.0 110.0 113.0 112.0 113.0 124.0 113.0 112.0 113.0 112.0 23:04:08 INFO - PROCESS | 5593 | 23:04:08 INFO - PROCESS | 5593 | [#1] audio-beat-detection Cycles:10 Average:144.50 Median:151.00 stddev:15.04 (10.0%) stddev-sans-first:15.82 23:04:08 INFO - PROCESS | 5593 | Values: 150.0 126.0 155.0 164.0 128.0 152.0 148.0 134.0 163.0 125.0 23:04:08 INFO - PROCESS | 5593 | 23:04:08 INFO - PROCESS | 5593 | [#2] audio-dft Cycles:10 Average:162.60 Median:162.00 stddev:2.22 (1.4%) stddev-sans-first:2.28 23:04:08 INFO - PROCESS | 5593 | Values: 161.0 162.0 161.0 162.0 164.0 161.0 162.0 164.0 168.0 161.0 23:04:08 INFO - PROCESS | 5593 | 23:04:08 INFO - PROCESS | 5593 | [#3] audio-fft Cycles:10 Average:79.00 Median:72.50 stddev:21.13 (29.2%) stddev-sans-first:22.26 23:04:08 INFO - PROCESS | 5593 | Values: 72.0 73.0 75.0 71.0 73.0 72.0 74.0 139.0 71.0 70.0 23:04:08 INFO - PROCESS | 5593 | 23:04:08 INFO - PROCESS | 5593 | [#4] audio-oscillator Cycles:10 Average:110.20 Median:96.00 stddev:22.89 (23.8%) stddev-sans-first:23.70 23:04:08 INFO - PROCESS | 5593 | Values: 96.0 96.0 150.0 94.0 98.0 96.0 143.0 97.0 96.0 136.0 23:04:08 INFO - PROCESS | 5593 | 23:04:08 INFO - PROCESS | 5593 | [#5] imaging-gaussian-blur Cycles:10 Average:110.20 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 23:04:08 INFO - PROCESS | 5593 | Values: 111.0 110.0 110.0 110.0 110.0 110.0 110.0 111.0 111.0 109.0 23:04:08 INFO - PROCESS | 5593 | 23:04:08 INFO - PROCESS | 5593 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 23:04:08 INFO - PROCESS | 5593 | Values: 148.0 148.0 150.0 147.0 148.0 149.0 147.0 148.0 147.0 147.0 23:04:08 INFO - PROCESS | 5593 | 23:04:08 INFO - PROCESS | 5593 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 23:04:08 INFO - PROCESS | 5593 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 97.0 96.0 97.0 23:04:08 INFO - PROCESS | 5593 | 23:04:08 INFO - PROCESS | 5593 | [#8] json-parse-financial Cycles:10 Average:60.20 Median:60.00 stddev:1.62 (2.7%) stddev-sans-first:1.58 23:04:08 INFO - PROCESS | 5593 | Values: 62.0 59.0 59.0 60.0 60.0 64.0 60.0 60.0 59.0 59.0 23:04:08 INFO - PROCESS | 5593 | 23:04:08 INFO - PROCESS | 5593 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 23:04:08 INFO - PROCESS | 5593 | Values: 68.0 68.0 68.0 68.0 68.0 68.0 68.0 67.0 68.0 68.0 23:04:08 INFO - PROCESS | 5593 | 23:04:08 INFO - PROCESS | 5593 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:88.50 stddev:2.02 (2.3%) stddev-sans-first:2.03 23:04:08 INFO - PROCESS | 5593 | Values: 87.0 87.0 93.0 88.0 89.0 88.0 92.0 89.0 88.0 88.0 23:04:08 INFO - PROCESS | 5593 | 23:04:08 INFO - PROCESS | 5593 | [#11] stanford-crypto-ccm Cycles:10 Average:122.10 Median:122.00 stddev:3.70 (3.0%) stddev-sans-first:3.91 23:04:08 INFO - PROCESS | 5593 | Values: 123.0 117.0 120.0 120.0 121.0 127.0 119.0 129.0 121.0 124.0 23:04:08 INFO - PROCESS | 5593 | 23:04:08 INFO - PROCESS | 5593 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.80 Median:152.50 stddev:4.21 (2.8%) stddev-sans-first:4.24 23:04:08 INFO - PROCESS | 5593 | Values: 146.0 154.0 150.0 153.0 144.0 144.0 155.0 152.0 153.0 147.0 23:04:08 INFO - PROCESS | 5593 | 23:04:08 INFO - PROCESS | 5593 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:2.28 (3.2%) stddev-sans-first:2.39 23:04:08 INFO - PROCESS | 5593 | Values: 72.0 69.0 69.0 71.0 70.0 69.0 73.0 71.0 69.0 76.0 23:04:08 INFO - PROCESS | 5593 | -------- Summary: end -------- 23:04:08 INFO - PROCESS | 5593 | 23:04:09 INFO - TEST-INFO | 5593: exit 0 23:04:09 INFO - TEST-OK | kraken | took 61208ms 23:04:09 INFO - TEST-START | v8_7 23:04:09 INFO - operating with platform_type : linux_ 23:04:09 INFO - Initialising browser for v8_7 test... 23:04:09 INFO - TEST-INFO | started process 5882 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkdpkpj/profile http://localhost:59358/getInfo.html) 23:04:14 INFO - PROCESS | 5882 | __metrics Screen width/height:1600/1200 23:04:14 INFO - PROCESS | 5882 | colorDepth:24 23:04:14 INFO - PROCESS | 5882 | Browser inner width/height: 1024/697 23:04:14 INFO - PROCESS | 5882 | __metrics 23:04:14 INFO - PROCESS | 5882 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:04:14 INFO - PROCESS | 5882 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 23:04:15 INFO - TEST-INFO | 5882: exit 0 23:04:15 INFO - Browser initialized. 23:04:15 INFO - Running cycle 1/1 for v8_7 test... 23:04:15 INFO - TEST-INFO | started process 6007 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpkdpkpj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:04:27 INFO - PROCESS | 6007 | RSS: Main: 149508096 23:04:27 INFO - PROCESS | 6007 | 23:04:48 INFO - PROCESS | 6007 | Cycle 1(1): loaded http://localhost:59358/tests/v8_7/run.html (next: http://localhost:59358/tests/v8_7/run.html) 23:04:49 INFO - PROCESS | 6007 | RSS: Main: 146505728 23:04:49 INFO - PROCESS | 6007 | 23:04:49 INFO - PROCESS | 6007 | __start_tp_report 23:04:49 INFO - PROCESS | 6007 | _x_x_mozilla_page_load 23:04:49 INFO - PROCESS | 6007 | _x_x_mozilla_page_load_details 23:04:49 INFO - PROCESS | 6007 | |i|pagename|runs| 23:04:49 INFO - PROCESS | 6007 | |0;Richards;168.15200941651253 23:04:49 INFO - PROCESS | 6007 | |1;DeltaBlue;186.15040953090096 23:04:49 INFO - PROCESS | 6007 | |2;Encrypt;279.87685418415896 23:04:49 INFO - PROCESS | 6007 | |3;Decrypt;5229.166666666667 23:04:49 INFO - PROCESS | 6007 | |4;RayTrace;1066.0980810234541 23:04:49 INFO - PROCESS | 6007 | |5;Earley;704.7216349541931 23:04:49 INFO - PROCESS | 6007 | |6;Boyer;12192.77108433735 23:04:49 INFO - PROCESS | 6007 | |7;RegExp;25375 23:04:49 INFO - PROCESS | 6007 | |8;Splay;636.5372374283895 23:04:49 INFO - PROCESS | 6007 | |9;NavierStokes;4850.241545893719 23:04:49 INFO - PROCESS | 6007 | __end_tp_report 23:04:49 INFO - PROCESS | 6007 | __startTimestamp1451977489123__endTimestamp 23:04:49 INFO - PROCESS | 6007 | 23:04:49 INFO - PROCESS | 6007 | ------- Summary: start ------- 23:04:49 INFO - PROCESS | 6007 | Number of tests: 10 23:04:49 INFO - PROCESS | 6007 | 23:04:49 INFO - PROCESS | 6007 | [#0] Richards Cycles:1 Average:168.15 Median:168.15 stddev:0.00 (0.0%) 23:04:49 INFO - PROCESS | 6007 | Values: 168.2 23:04:49 INFO - PROCESS | 6007 | 23:04:49 INFO - PROCESS | 6007 | [#1] DeltaBlue Cycles:1 Average:186.15 Median:186.15 stddev:0.00 (0.0%) 23:04:49 INFO - PROCESS | 6007 | Values: 186.2 23:04:49 INFO - PROCESS | 6007 | 23:04:49 INFO - PROCESS | 6007 | [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 23:04:49 INFO - PROCESS | 6007 | Values: 279.9 23:04:49 INFO - PROCESS | 6007 | 23:04:49 INFO - PROCESS | 6007 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 23:04:49 INFO - PROCESS | 6007 | Values: 5229.2 23:04:49 INFO - PROCESS | 6007 | 23:04:49 INFO - PROCESS | 6007 | [#4] RayTrace Cycles:1 Average:1066.10 Median:1066.10 stddev:0.00 (0.0%) 23:04:49 INFO - PROCESS | 6007 | Values: 1066.1 23:04:49 INFO - PROCESS | 6007 | 23:04:49 INFO - PROCESS | 6007 | [#5] Earley Cycles:1 Average:704.72 Median:704.72 stddev:0.00 (0.0%) 23:04:49 INFO - PROCESS | 6007 | Values: 704.7 23:04:49 INFO - PROCESS | 6007 | 23:04:49 INFO - PROCESS | 6007 | [#6] Boyer Cycles:1 Average:12192.77 Median:12192.77 stddev:0.00 (0.0%) 23:04:49 INFO - PROCESS | 6007 | Values: 12192.8 23:04:49 INFO - PROCESS | 6007 | 23:04:49 INFO - PROCESS | 6007 | [#7] RegExp Cycles:1 Average:25375.00 Median:25375.00 stddev:0.00 (0.0%) 23:04:49 INFO - PROCESS | 6007 | Values: 25375.0 23:04:49 INFO - PROCESS | 6007 | 23:04:49 INFO - PROCESS | 6007 | [#8] Splay Cycles:1 Average:636.54 Median:636.54 stddev:0.00 (0.0%) 23:04:49 INFO - PROCESS | 6007 | Values: 636.5 23:04:49 INFO - PROCESS | 6007 | 23:04:49 INFO - PROCESS | 6007 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 23:04:49 INFO - PROCESS | 6007 | Values: 4850.2 23:04:49 INFO - PROCESS | 6007 | -------- Summary: end -------- 23:04:49 INFO - PROCESS | 6007 | 23:04:50 INFO - TEST-INFO | 6007: exit 0 23:04:50 INFO - TEST-OK | v8_7 | took 40810ms 23:04:50 INFO - SUITE-END | took 1214s 23:04:50 INFO - Completed test suite (00:20:14) 23:04:50 INFO - Working with test: dromaeo_css 23:04:50 INFO - Generating results file: dromaeo_css 23:04:50 INFO - Working with test: kraken 23:04:50 INFO - Generating results file: kraken 23:04:50 INFO - javascript benchmark 23:04:50 INFO - Working with test: v8_7 23:04:50 INFO - Generating results file: v8_7 23:04:50 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:04:50 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 23:04:50 INFO - process_Request line: dromaeo_css 6911.03 graph.html#tests=[[72,64,43]] 23:04:50 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:04:50 INFO - process_Request line: kraken 1524.00 graph.html#tests=[[232,64,43]] 23:04:50 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:04:50 INFO - process_Request line: v8_7 21271.28 graph.html#tests=[[230,64,43]] 23:04:50 INFO - RETURN: dromaeo_css: 6911.03 23:04:50 INFO - RETURN: kraken: 1524.00 23:04:50 INFO - RETURN: v8_7: 21271.28 23:04:50 INFO - javascript benchmark 23:04:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3137.639171495278, 3168.334649723558, 3193.1538142392255, 3221.5167724841276, 3225.6451790303063, 5283.8150664726745, 5365.517103460693, 5372.462753724625, 5396.541293990011, 5402.135658294674, 5364.7317634118335, 5369.785208591652, 5453.400125986138, 5503.724813759316, 5535.03136951033, 4951.702897826133, 4977.800887964477, 4982.277569752384, 5053.494650534935, 5077.466865979074, 4995.275685025669, 5021.0, 5062.0, 5080.466551012128, 5082.161443361841, 4837.612990960714, 4843.176659967814, 4942.03630292095, 4976.2286845539, 4981.352424184869, 4871.488493708145, 4900.852974410774, 4931.65478416511, 4945.159322915077, 4960.181570040939, 4781.258904869751, 4900.191468407708, 4930.5069493050405, 4973.154563724175, 5013.0, 5187.325647665779, 5242.8689282767855, 5250.553702935217, 5292.259083728281, 5294.576433885319, 5747.051736463479, 5778.913316300259, 5783.5951483396175, 5783.739731712041, 5799.3910639382675, 5703.65778053314, 5807.767689292423, 5814.534837213013, 5822.475977162076, 5825.242718446617, 5406.783728650849, 5408.594355423359, 5411.9729401353525, 5413.350397952231, 5415.6479828811, 5822.155787410802, 5877.676727779927, 5920.31916329619, 5921.526277897758, 5985.072313791369, 5706.343770466367, 5748.051571490657, 5751.424857514299, 5757.0788673811985, 5763.366029736726, 5674.574406919498, 5801.9129713054335, 5827.300723913073, 5838.299404071454, 5844.503217226584, 5748.367679555246, 5751.971240143856, 5831.854203644858, 5834.387389324144, 5853.824385268449, 5742.856428589319, 5749.051406517878, 5773.88452230953, 5786.826395208151, 5787.247657804459, 4415.249407600716, 4450.643948484114, 4486.910261794811, 4493.326001099861, 4543.295789152687, 3950.9012274692786, 3986.5216174059296, 4022.738521996061, 4051.088505086391, 4060.634542891154, 5364.517193452608, 5413.160960051198, 5451.182322651634, 5455.236266922634, 5455.918161227505, 5782.826515204551, 5806.738696758572, 5818.156367326798, 5820.214271073435, 5862.736176872051, 5371.301730774974, 5372.247885296062, 5400.91898621521, 5482.23248745176, 5517.972410138004, 4922.261660750916, 4928.28539861718, 4934.9753251233515, 4945.480724523945, 4968.577670897942, 5963.761449541969, 5973.372795856372, 5981.611195272293, 5986.850328741816, 5988.880222395528, 5727.599068065196, 5796.739146738491, 5827.271591051119, 5828.533717302521, 5842.38654941225, 5934.0, 5982.880342393215, 5990.520758339235, 6008.459238668541, 6013.87972240544, 5608.46719561641, 5650.0677388232125, 5686.516646085129, 5697.772089116389, 5743.483086522233, 5731.828045158485, 5812.564057695605, 5824.155497452761, 5840.123981402823, 5884.264466941632, 5669.943300566942, 5685.346185188756, 5687.573431992534, 5691.914621280601, 5695.943040569541, 5589.441055894378, 5625.0, 5673.801416950387, 5688.459596338341, 5692.914606280826, 5551.361593416647, 5556.749946252347, 5574.86062848432, 5603.411641777555, 5635.182898479616, 5640.210370548209, 5684.374718781013, 5684.488396044376, 5685.232493613475, 5690.715464226855, 5461.726913654222, 5539.335279766454, 5544.0, 5567.164925261243, 5599.720013999366], "unit": "score", "name": "dojo.html", "value": 5342.615782088756}, {"lowerIsBetter": false, "replicates": [536.1368197202506, 541.4774742373609, 561.4077148608219, 562.13150682196, 571.3515160293068, 35466.64533354666, 36239.81880090599, 36453.635463645354, 36507.087322816944, 36539.634603653954, 39362.40956385656, 39862.402063969064, 40088.19823603526, 40124.19751604966, 40309.79845100778, 8484.575771211461, 8579.742607721779, 8602.612882420275, 8633.0, 8665.220130188281, 8497.490150590984, 8516.957415212915, 8520.40357174998, 8751.212390884819, 8773.0, 8706.042335343107, 8786.165314295164, 8803.867941980876, 8832.249258813008, 8836.116388361144, 8696.086910874394, 8697.95651021744, 8700.608472618684, 8789.824203515926, 8792.956035219815, 8574.657013719443, 8699.260562852101, 8733.825323493558, 8737.126287371211, 8772.517511536864, 38945.221095578214, 39440.40839387412, 39503.40744888829, 39508.604913951065, 39601.40597891034, 2822.816516926414, 3194.648588655246, 3378.4256676365076, 3704.4072948328408, 4043.7573745575064, 26074.34053949323, 26127.0, 26306.605400919, 26706.19881403561, 27543.862280688667, 3072.800267982574, 3099.318150006995, 3128.7184153426074, 3185.442547554192, 3247.0745837436452, 216280.0, 217815.0, 217847.0, 217986.0, 218551.0, 53383.46616533863, 54467.18299225515, 54822.72588637031, 54954.725226373615, 66851.66574167098, 59117.0, 59278.40721592815, 59394.70302648459, 59400.0, 59616.0, 14147.929260353632, 14487.348069336906, 14497.855021449861, 14499.420023199165, 14512.564623061326, 10419.322744021614, 10556.049955504042, 10605.946970265099, 10610.787784244272, 10621.89378106209, 19896.801031989784, 20178.486613504047, 20235.696464553042, 20288.898555507127, 20364.592708145756, 7452.552846829208, 7625.961870190614, 7727.65225564851, 7776.65005074773, 7828.7266336475295, 918.4213945214472, 952.4428209497383, 974.2546951582045, 998.9511013436008, 1134.2627292260097, 27777.44445111127, 28490.860365585144, 28535.28661783472, 28600.284992875346, 31718.04845854628, 982.9262805289632, 1001.4141727089734, 1045.6862941117633, 1076.7039064257392, 1078.6710053433778, 13837.238951857544, 13895.930520347334, 13949.58151255464, 14002.299885005912, 14185.645358865904, 326689.0, 331033.75875463116, 332236.0, 333545.0, 333734.0, 51504.48495515072, 52010.219846702326, 52183.47816521862, 52191.47808521866, 52218.47781522212, 1339.4709089909627, 1345.0, 1355.2275203134118, 1374.883134933542, 1485.4800819713014, 25828.19202655796, 26161.0, 26241.0, 26345.60481592816, 26471.735282647696, 43776.781116094215, 43979.78010109929, 43999.12001759883, 44330.335044975, 44383.77808110939, 296850.0, 302176.0, 302544.0, 303135.0, 303697.0, 29865.5520167202, 32154.19614509656, 32416.83791581027, 32699.673003270615, 32781.34437311288, 38894.2221155581, 42037.0, 42321.576784231765, 42855.35716964186, 43424.13151736884, 32058.0, 32428.675713242566, 32718.83640581782, 32962.67037329692, 33343.83328083344, 32498.350032998736, 32580.185495361857, 32737.836310818293, 32826.17934551655, 32947.67052329542, 32108.924371828198, 32378.514322285657, 32556.37218139036, 32877.0, 32987.67012329846, 30360.54459183158, 31465.685343146277, 32237.838810805795, 32376.83811580927, 32414.351712965137, 24276.271711848673, 24680.382990425383, 24745.25764227076, 24899.751002489742, 25286.24141275765], "unit": "score", "name": "ext.html", "value": 17783.011883697927}, {"lowerIsBetter": false, "replicates": [360.533109623038, 361.29727679663057, 364.81941438987707, 366.7799320407756, 367.05666437256247, 16088.115153666544, 16897.49307520775, 17389.739153912702, 17551.12244387782, 18042.548936276566, 15886.0, 16022.19889005551, 16077.919610401961, 16459.67080658386, 16509.66980660389, 4940.678855874366, 5082.0598189334905, 5083.906960003598, 5098.770555325019, 5122.513361230677, 5042.672226305297, 5070.518300761421, 5074.771635276403, 5091.389033316007, 5201.427842937273, 4953.900921981558, 5158.3552055993005, 5163.561097306733, 5434.972825135888, 5466.753996070166, 5115.155999260118, 5136.126858434075, 5137.537621614073, 5139.4346621871755, 5415.810446634388, 4998.875028124289, 5004.249362595603, 5004.374453193351, 5011.273365362039, 5025.396952365703, 18969.525761855926, 19807.60384792296, 20625.896870515553, 20631.793682063286, 20713.27503537369, 1937.82559569638, 1969.7045443183495, 2072.492239401341, 2156.7735387784214, 2228.699125618053, 6755.054292399068, 9106.68126615572, 9630.133288004043, 11153.940375664299, 12493.063020273516, 1755.2276998120785, 1773.1134432783608, 1857.6284743051308, 1872.4850666066804, 1941.8446524278165, 56243.0, 59580.0, 59602.701986490225, 60113.398866011215, 60947.39052609461, 10256.487175641189, 10407.271490995558, 10454.42500662471, 10456.163506919429, 10492.160627149962, 13397.397117129753, 13560.11859229147, 13583.728325433436, 13597.728045439037, 13620.795688064687, 7204.459665525106, 7277.345038946521, 7292.927070729331, 7307.926920730724, 7349.448791340564, 6971.407430368476, 7002.929970700329, 7011.474139439562, 7031.296870312928, 7035.085438892911, 4429.424174857248, 4491.30384790358, 4519.367288579601, 4542.205114105019, 4561.133384656904, 1736.0278244183298, 1780.5459607799928, 1828.8628352873322, 1843.3363988963963, 1883.4820424383404, 849.3120572336427, 946.3044662173297, 947.8530827721577, 959.7264779537799, 1009.0716540782498, 14416.351264193136, 15355.23223838826, 15726.370945162294, 16463.423780167635, 16838.242279097223, 917.8806755121791, 943.6649989253854, 944.5749412764284, 969.147150507563, 985.4085651672498, 9373.297002724823, 9406.529673516297, 9577.23382129428, 9605.991370906095, 9796.216302695768, 512790.9767218688, 525582.0, 526241.0, 526543.0, 546950.0, 72571.0, 73752.63123684347, 74833.0, 76939.61530192425, 77726.2227377719, 1079.1097344690504, 1084.3168803653805, 1139.9373034483017, 1155.2952698853692, 1155.6186458468685, 14957.775633365725, 15041.473548425753, 15177.317020733874, 15187.924060379628, 15478.767818482507, 33233.66766332403, 33471.16322091967, 34563.82718086393, 35003.64996350004, 35165.47251791174, 45711.0, 45725.77137114293, 45927.311090333, 48242.51757482521, 48776.51223487862, 9398.812023759623, 9558.28312876551, 9938.155256803253, 9952.0, 10011.24915631316, 11761.764764704829, 11826.881731182579, 17111.401100961408, 17422.651546969242, 17652.823471765118, 10885.945570272099, 13374.598762037154, 13754.724905502035, 13764.17414955106, 14259.64350891236, 13242.470301187845, 13459.259740714355, 13576.728465430439, 13729.244891531062, 13860.930695346458, 13987.790183147057, 14004.649883752987, 14120.2939853009, 14161.575152745021, 14233.786493202817, 8847.55762211874, 8984.0, 9007.63969441215, 9015.467370547154, 9411.4823684698, 10064.647737329158, 11288.774224515628, 13844.0, 13890.374933127832, 14454.060486068372], "unit": "score", "name": "jquery.html", "value": 8674.319616495057}, {"lowerIsBetter": false, "replicates": [1455.2141843404563, 1483.3176738700195, 1511.984880151199, 1541.7995660564125, 1582.3037863340137, 7541.736039238628, 7691.307782299592, 7698.384129269659, 7791.688332466709, 7887.960560197191, 7865.8033549161155, 7939.841203175933, 7943.165967573408, 7974.681012759483, 7979.960100199505, 2234.1175235781857, 2262.4343914021497, 2272.091163534583, 2278.236790675126, 2278.3620586235797, 2269.977300226993, 2294.403455101669, 2363.078399424226, 2366.9408264793433, 2367.7868991790733, 1984.3650031989769, 2017.788132246115, 2238.9888050559807, 2262.4230821140586, 2298.8965496552696, 2239.5632851593946, 2241.3388050525136, 2248.336740661509, 2249.4376405898524, 2252.4594097416666, 2225.8887055647315, 2270.262164796448, 2277.9886100569556, 2288.725352957639, 2293.048384920256, 7791.649375778104, 7855.253750893656, 7858.489198202098, 7864.921350786476, 7874.724384646567, 4563.429571303587, 4633.235516139833, 4690.742009189493, 4721.24460086388, 4723.338732577442, 3004.2939909121337, 3028.6971302869756, 3029.182120827364, 3035.347400308944, 3042.574039634453, 947.947862867542, 971.3686104032436, 974.2060220919998, 976.5556671714353, 1052.8420736889452, 10870.130389568816, 10939.781204375868, 10994.175436842188, 10999.725006874893, 11025.61410350642, 4043.4541336919137, 4071.6131967463043, 4094.9181016379507, 4115.650169735546, 4222.852200172979, 8786.86819697705, 8815.030346661862, 8816.250618697355, 8843.955780221186, 8859.689910853089, 4544.545545445429, 4554.27131658933, 4578.725276483422, 4580.244259697112, 4583.060472603109, 4188.643965262926, 4197.370394440797, 4229.407882896397, 4235.97882010588, 4245.97877010613, 3404.2510647657477, 3412.4369479036177, 3413.9487907681405, 3434.1929646533044, 3439.6904278614543, 1031.169908223887, 1052.936823790575, 1065.1638463805875, 1067.754416484213, 1084.2789544952675, 899.0649724286799, 924.1867156901883, 1048.7116043088213, 1073.9958139139928, 1132.5752842683994, 6970.651467426608, 6982.581045137308, 7008.983697363854, 7068.823279417953, 7073.504854660125, 609.3236507476697, 616.7132283488199, 634.8539835837784, 640.3692363022419, 768.2164192523707, 5299.708516031656, 5515.034868898007, 5516.613837031449, 5517.972410137923, 5523.944760552343, 9166.404183728037, 9226.21577165935, 9382.90617093834, 9389.530523473799, 9491.145796878314, 9114.635414583476, 9154.954225228832, 9167.816643667089, 9169.174774270348, 9181.816363672822, 7176.928230717626, 7326.120865496175, 7351.926480735231, 7404.851902961911, 7429.108506979197, 7312.41500679955, 7339.9633001834645, 7363.079615048119, 7403.222661620668, 7416.7774966751085, 8266.669333226604, 8423.284020858297, 8444.197801208875, 8463.111373305714, 8522.0, 8332.500049996777, 8537.762024506535, 8555.31557475388, 8608.956955215184, 8634.78413039679, 6850.0409942607075, 6898.413634841095, 7031.191412987572, 7194.100737407824, 7194.4244460442, 7641.388688904985, 7696.037995250594, 7777.300042996158, 7787.922120778946, 7797.337226335598, 7090.4682148840075, 7180.3537681608905, 7250.709971601077, 7280.3083707047745, 7402.037735094404, 6784.13088585801, 6891.517593768388, 6933.7226510939, 6945.617991010543, 7034.859302814018, 7177.354038136593, 7179.066721326194, 7189.892151617625, 7198.280171982759, 7220.3140701633265, 6092.969535152296, 6129.969350153221, 6131.110988906673, 6152.569320147547, 6196.070589411444, 6600.471962242913, 6637.402633762985, 6682.164729408824, 6722.932770672426, 6726.058351830846], "unit": "score", "name": "mootools.html", "value": 4368.036464878387}, {"lowerIsBetter": false, "replicates": [343.0976531721572, 344.72766514453565, 347.0185242266657, 352.31474781549895, 353.05909750514877, 6152.5385596080305, 6174.166487524189, 6201.224846894138, 6217.160683307752, 6330.145430366899, 6154.753809847601, 6187.721552530135, 6217.347178546255, 6253.0, 6256.0, 4704.1062198182235, 4706.694064885789, 4713.316569097479, 4715.269133284346, 4717.056588682261, 4713.481517033124, 4720.197566413718, 4723.48041715411, 4732.361131247272, 4740.549647783455, 4542.114287713897, 4563.543645635426, 4619.976900115495, 4640.257558790594, 4688.648351373644, 4582.793774280165, 4589.495155532889, 4597.586217240464, 4616.884577885546, 4619.122366750306, 3974.364101743707, 3986.920261594752, 4034.636882680573, 4040.4141399497203, 4052.0680243543857, 5869.325027621793, 5897.557683173736, 5899.2920849497905, 5905.320888097838, 5920.171176035358, 5292.153255479144, 5425.321834770653, 5460.071787796044, 5493.670379777226, 5514.889702205934, 6565.835854103638, 6570.770023049218, 6593.406593406617, 6601.141851559315, 6602.5708328958945, 4537.9773101134615, 4540.477845047829, 4543.613792827614, 4547.15877562652, 4548.385967894325, 6748.460123190133, 6870.244273129952, 6909.550879192887, 6933.375996160319, 6946.409555187815, 4657.138429390574, 4657.6273898088075, 4662.603678687349, 4665.766711664471, 4668.626509879202, 4706.670533062721, 4707.0, 4712.976435117803, 4716.457607375196, 4725.385699858996, 5461.453854614586, 5474.698891560923, 5478.91781623276, 5479.0959491684225, 5485.835424937259, 6507.609543427409, 6666.500012498985, 6668.499862510234, 6674.733010679518, 6675.065490831287, 1639.1148779658852, 1659.7842280503457, 1659.7925259342583, 1664.3924967387059, 1665.775120358736, 1097.067492631257, 1097.6048622495896, 1105.5080489182237, 1116.9329840209614, 1123.4270522033657, 6299.748010079637, 6301.0863424804065, 6301.684915754194, 6307.369263073656, 6320.273168585672, 6829.180498340231, 6842.692078856463, 6852.897206541906, 6856.24581296057, 6863.6568171591225, 6163.260408750889, 6292.370762923671, 6302.873942521124, 6330.39861213184, 6367.808965731036, 3676.4117741161285, 3706.388445906395, 3708.35103856824, 3727.366347720894, 3732.0856390184035, 7147.499675022803, 7170.533915295593, 7212.0, 7216.242294559101, 7235.565866048054, 6949.791506254821, 7015.193252775894, 7060.823479412953, 7062.6821793019435, 7095.361417472453, 7208.171060328024, 7231.783046508614, 7239.20368759436, 7239.9999999998945, 7258.056452661121, 6842.7683017055415, 6855.348741869514, 6894.0, 6908.758193463204, 6911.688973996082, 6738.46092312604, 6808.693608787517, 6863.450923926173, 6878.140232470942, 6879.724811007503, 7239.203687594466, 7257.0, 7257.2742725727, 7258.709651613876, 7261.564306141437, 4629.88425289357, 4632.305154226893, 4661.091087238092, 4664.580187783115, 4665.533446655443, 6731.293214212633, 6915.965420173068, 6941.305869413019, 6942.500699747986, 6949.409300209539, 6742.089817874524, 6744.629045402354, 6745.291744366771, 6759.188897332351, 6762.154730658668, 6678.332166783282, 6711.194656641039, 6713.765018224339, 6716.227633822173, 6725.4283385910785, 6399.584027038228, 6606.43845273138, 6615.867682646224, 6616.7022483987375, 6632.336766323329, 6708.228553716385, 6746.224184218681, 6748.392644662004, 6765.42493888025, 6774.390304872585, 6435.742570297136, 6513.1532900722605, 6535.509836762167, 6608.570442921195, 6616.437602803816], "unit": "score", "name": "prototype.html", "value": 4986.226256137626}, {"lowerIsBetter": false, "replicates": [754.6981207516995, 765.7243392378739, 771.4021633234242, 783.1385475976426, 823.8764185372195, 12820.230786152826, 13062.542811001616, 13086.214827110369, 13101.08292419531, 13114.34428278587, 12617.4322155503, 12647.367631618405, 12720.427580758866, 12726.618201453948, 12727.363631818418, 830.489249111795, 831.1605278668528, 846.7925358287229, 846.8602680557732, 848.1942154952819, 835.8620827563444, 844.4384484317952, 844.7676888855583, 845.8266055458616, 848.0755975986174, 851.2551517422255, 852.8805967164602, 855.6149732620314, 864.2437866866492, 880.8326417980563, 858.4977787994031, 860.3934226370394, 864.2351518905782, 883.8983516895511, 889.2263730554427, 646.7639311651213, 647.8769033883547, 648.3710800523485, 648.7469886744126, 648.915640966676, 14180.85819141816, 14288.142711437244, 14324.856751432457, 14326.426942922271, 14335.56993290203, 11535.077193824558, 11946.581869634521, 12306.81539776904, 12312.199707019015, 12734.61796146117, 9989.700308990741, 10057.195424366033, 10240.719286258905, 10320.0, 10702.51838667254, 3525.4006818840603, 3609.8375573099274, 3609.9531135970537, 3622.7826330420257, 3670.5595328560476, 48943.0, 48947.0, 49066.50933490655, 49220.50779492195, 49687.50312496901, 9707.854382184272, 10027.097561219525, 10076.848847267296, 10274.126699230499, 10575.418351990715, 17398.826011739973, 17468.91265543664, 17506.299748009937, 17508.299668013136, 17520.0, 7337.19290878003, 7398.926010739824, 7498.100227972678, 7608.391328693691, 7623.428242881695, 4159.584041595816, 4176.164767046542, 4242.045539753531, 4299.505556860939, 4416.889577760582, 3039.8024128432025, 3087.320789426323, 3092.969070309313, 3095.92260193497, 3096.442640324718, 535.7776522743096, 536.0592160757845, 544.727636181909, 550.4083110656061, 555.3280530557989, 512.456795796457, 530.9601779866525, 536.3831593667314, 586.3403670870271, 664.6244871647503, 7844.9607751960875, 8219.712310069119, 8235.794105147419, 8260.173982601691, 8884.156005179497, 595.3332267860025, 610.3133974278936, 655.2137435077925, 678.260695841535, 729.824842037907, 3723.4414837774552, 3768.2651882883124, 3825.9617403825605, 3852.325842977468, 3870.322693528621, 49624.0, 49880.750596246784, 50752.492475075516, 51098.23352649713, 52286.21570676443, 47105.822354441414, 47715.28427073597, 47728.28407573889, 47824.52175478201, 48698.0, 42866.57133428626, 43323.56676433259, 43403.782981085526, 44469.0, 44957.77521112439, 7429.257074292527, 7683.538987660758, 7716.0, 7723.189065148079, 8017.559034253172, 32748.83625581857, 32801.34397312088, 33237.0, 33767.49348759722, 34083.0, 42170.78914605407, 42418.15163696647, 42661.57338426576, 42762.0, 43499.56500434955, 9824.557894894604, 10056.29605927578, 10138.23963202748, 10408.411159122992, 10528.0, 10599.258051936291, 10960.506777194885, 10982.505787239754, 11541.192116551762, 11558.884411155781, 9223.400478968846, 9383.155516003593, 9533.666321678707, 10053.04496072872, 10078.79842403133, 9259.953700231456, 9527.714168574954, 9529.761755955878, 9615.375000624937, 9729.513524323896, 9909.65316213929, 10058.195344372287, 10132.392056476636, 10236.0, 10344.0, 9124.95437522808, 9173.816523669622, 9256.0, 9257.259419246579, 9264.861027084464, 8355.791105222417, 8774.912250877665, 8782.253508451598, 8849.734507964771, 8853.778655533662], "unit": "score", "name": "yui.html", "value": 6069.683697455634}], "name": "dromaeo_css", "value": 6911.02763212417}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 110.0, 113.0, 112.0, 113.0, 124.0, 113.0, 112.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.5}, {"lowerIsBetter": true, "replicates": [150.0, 126.0, 155.0, 164.0, 128.0, 152.0, 148.0, 134.0, 163.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 144.5}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 162.0, 164.0, 161.0, 162.0, 164.0, 168.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 75.0, 71.0, 73.0, 72.0, 74.0, 139.0, 71.0, 70.0], "unit": "score", "name": "audio-fft", "value": 79.0}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 150.0, 94.0, 98.0, 96.0, 143.0, 97.0, 96.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 110.2}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 111.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.2}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 150.0, 147.0, 148.0, 149.0, 147.0, 148.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [62.0, 59.0, 59.0, 60.0, 60.0, 64.0, 60.0, 60.0, 59.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 60.2}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [87.0, 87.0, 93.0, 88.0, 89.0, 88.0, 92.0, 89.0, 88.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.9}, {"lowerIsBetter": true, "replicates": [123.0, 117.0, 120.0, 120.0, 121.0, 127.0, 119.0, 129.0, 121.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.1}, {"lowerIsBetter": true, "replicates": [146.0, 154.0, 150.0, 153.0, 144.0, 144.0, 155.0, 152.0, 153.0, 147.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.8}, {"lowerIsBetter": true, "replicates": [72.0, 69.0, 69.0, 71.0, 70.0, 69.0, 73.0, 71.0, 69.0, 76.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.9}], "name": "kraken", "value": 1524.0000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.15200941651253], "unit": "score", "name": "Richards", "value": 209.94099399999996}, {"lowerIsBetter": false, "replicates": [186.15040953090096], "unit": "score", "name": "DeltaBlue", "value": 355.1858960000002}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1066.0980810234541], "unit": "score", "name": "RayTrace", "value": 694.109682}, {"lowerIsBetter": false, "replicates": [704.7216349541931], "unit": "score", "name": "Earley", "value": 945.7109970000002}, {"lowerIsBetter": false, "replicates": [12192.77108433735], "unit": "score", "name": "Boyer", "value": 54.66050296442688}, {"lowerIsBetter": false, "replicates": [25375.0], "unit": "score", "name": "RegExp", "value": 35.90088669950742}, {"lowerIsBetter": false, "replicates": [636.5372374283895], "unit": "score", "name": "Splay", "value": 128.02236099999996}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 21271.27892316368}]} 23:04:50 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21271.28"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1524.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "6911.03"}}} 23:04:50 INFO - Return code: 0 23:04:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:04:50 INFO - # TBPL SUCCESS # 23:04:50 INFO - Running post-action listener: _resource_record_post_action 23:04:50 INFO - Running post-run listener: _resource_record_post_run 23:04:51 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 16384; Write bytes: 317763584; Read time: 40; Write time: 339012 23:04:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5545984; Read time: 0; Write time: 648 23:04:51 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 16384; Write bytes: 312217600; Read time: 40; Write time: 338364 23:04:51 INFO - Running post-run listener: _upload_blobber_files 23:04:51 INFO - Blob upload gear active. 23:04:51 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:04:51 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 23:04:51 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'] 23:04:51 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 23:04:51 INFO - (blobuploader) - INFO - Open directory for files ... 23:04:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:04:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:04:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:04:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:04:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:04:52 INFO - (blobuploader) - INFO - Done attempting. 23:04:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:04:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:04:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:04:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:04:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:04:53 INFO - (blobuploader) - INFO - Done attempting. 23:04:53 INFO - (blobuploader) - INFO - Iteration through files over. 23:04:53 INFO - Return code: 0 23:04:53 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:04:53 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:04:53 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aba4b984dc642405eca9b15cbac627da4a96380e1ac5afb4b3b47f6c51e0ee7d250834bcee328b64bfd747d38f27827dd6c5289cfa033ebec525cd543a5ea3ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0c0105f6e34e9cd651d42339d4e14689cc3394b14222e6f7b8385ac5ee7be048245296b658a16f11bf548aed1b6205a47c8bc421e17742fa93ef202168cce14"} 23:04:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:04:53 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:04:53 INFO - Contents: 23:04:53 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/aba4b984dc642405eca9b15cbac627da4a96380e1ac5afb4b3b47f6c51e0ee7d250834bcee328b64bfd747d38f27827dd6c5289cfa033ebec525cd543a5ea3ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0c0105f6e34e9cd651d42339d4e14689cc3394b14222e6f7b8385ac5ee7be048245296b658a16f11bf548aed1b6205a47c8bc421e17742fa93ef202168cce14"} 23:04:53 INFO - Copying logs to upload dir... 23:04:53 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1286.471662 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2016-01-04 23:04:53.444862) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 23:04:53.448688) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928 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/aba4b984dc642405eca9b15cbac627da4a96380e1ac5afb4b3b47f6c51e0ee7d250834bcee328b64bfd747d38f27827dd6c5289cfa033ebec525cd543a5ea3ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0c0105f6e34e9cd651d42339d4e14689cc3394b14222e6f7b8385ac5ee7be048245296b658a16f11bf548aed1b6205a47c8bc421e17742fa93ef202168cce14"} build_url:https://queue.taskcluster.net/v1/task/ANUwb1ljRzSi650wroDu2A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011283 build_url: 'https://queue.taskcluster.net/v1/task/ANUwb1ljRzSi650wroDu2A/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/aba4b984dc642405eca9b15cbac627da4a96380e1ac5afb4b3b47f6c51e0ee7d250834bcee328b64bfd747d38f27827dd6c5289cfa033ebec525cd543a5ea3ab", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e0c0105f6e34e9cd651d42339d4e14689cc3394b14222e6f7b8385ac5ee7be048245296b658a16f11bf548aed1b6205a47c8bc421e17742fa93ef202168cce14"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 23:04:53.477102) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 23:04:53.477540) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1451974708.841319-107239928 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 23:04:53.560141) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 23:04:53.560510) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 23:04:53.560801) ========= ========= Total master_lag: 0.23 =========