builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1452085404.52 results: success (0) buildid: 20160106023011 builduid: 4650683aa9ec4810bd902957b8b630b0 revision: 444097473d1a78553a360b82a2d123cfad306492 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.522196) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.522779) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.523079) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006289 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.552978) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.553296) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.597934) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.598271) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004692 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.652160) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.652442) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.652932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.653229) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-06 05:03:24-- 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% 42.7M=0s 2016-01-06 05:03:24 (42.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117999 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.792328) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.792741) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018634 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.844909) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:24.845304) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 444097473d1a78553a360b82a2d123cfad306492 --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 444097473d1a78553a360b82a2d123cfad306492 --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=a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-06 05:03:25,085 truncating revision to first 12 chars 2016-01-06 05:03:25,085 Setting DEBUG logging. 2016-01-06 05:03:25,085 attempt 1/10 2016-01-06 05:03:25,085 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/444097473d1a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-06 05:03:25,411 unpacking tar archive at: fx-team-444097473d1a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.585318 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:25.445937) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:25.446267) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:25.457113) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:25.457357) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-06 05:03:25.457719) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-06 05:03:25.458010) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:03:25 INFO - MultiFileLogger online at 20160106 05:03:25 in /builds/slave/test-pgo 05:03:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:03:25 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:03:25 INFO - {'append_to_log': False, 05:03:25 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:03:25 INFO - 'blob_upload_branch': 'Fx-Team', 05:03:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:03:25 INFO - 'branch': 'Fx-Team', 05:03:25 INFO - 'buildbot_json_path': 'buildprops.json', 05:03:25 INFO - 'config_files': ('talos/linux_config.py',), 05:03:25 INFO - 'default_actions': ('clobber', 05:03:25 INFO - 'read-buildbot-config', 05:03:25 INFO - 'download-and-extract', 05:03:25 INFO - 'populate-webroot', 05:03:25 INFO - 'create-virtualenv', 05:03:25 INFO - 'install', 05:03:25 INFO - 'run-tests'), 05:03:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:03:25 INFO - 'download_minidump_stackwalk': True, 05:03:25 INFO - 'download_symbols': 'ondemand', 05:03:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:03:25 INFO - 'tooltool.py': '/tools/tooltool.py', 05:03:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:03:25 INFO - '/tools/misc-python/virtualenv.py')}, 05:03:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:03:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:03:25 INFO - 'installer_path': 'installer.exe', 05:03:25 INFO - 'log_level': 'info', 05:03:25 INFO - 'log_name': 'talos', 05:03:25 INFO - 'log_to_console': True, 05:03:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:03:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:03:25 INFO - 'opt_config_files': (), 05:03:25 INFO - 'pip_index': False, 05:03:25 INFO - 'sps_profile': False, 05:03:25 INFO - 'sps_profile_interval': 0, 05:03:25 INFO - 'suite': 'dromaeojs', 05:03:25 INFO - 'system_bits': '32', 05:03:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:03:25 INFO - 'title': 'talos-linux64-ix-062', 05:03:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:03:25 INFO - 'use_talos_json': True, 05:03:25 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:03:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:03:25 INFO - 'work_dir': 'build'} 05:03:25 INFO - ##### 05:03:25 INFO - ##### Running clobber step. 05:03:25 INFO - ##### 05:03:25 INFO - Running pre-action listener: _resource_record_pre_action 05:03:25 INFO - Running main action method: clobber 05:03:25 INFO - rmtree: /builds/slave/test-pgo/build 05:03:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:03:26 INFO - Running post-action listener: _resource_record_post_action 05:03:26 INFO - ##### 05:03:26 INFO - ##### Running read-buildbot-config step. 05:03:26 INFO - ##### 05:03:26 INFO - Running pre-action listener: _resource_record_pre_action 05:03:26 INFO - Running main action method: read_buildbot_config 05:03:26 INFO - Using buildbot properties: 05:03:26 INFO - { 05:03:26 INFO - "project": "", 05:03:26 INFO - "product": "firefox", 05:03:26 INFO - "script_repo_revision": "production", 05:03:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:03:26 INFO - "repository": "", 05:03:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:03:26 INFO - "buildid": "20160106023011", 05:03:26 INFO - "pgo_build": "True", 05:03:26 INFO - "basedir": "/builds/slave/test-pgo", 05:03:26 INFO - "buildnumber": 876, 05:03:26 INFO - "slavename": "talos-linux64-ix-062", 05:03:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:03:26 INFO - "platform": "ubuntu64_hw", 05:03:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:03:26 INFO - "branch": "fx-team", 05:03:26 INFO - "repo_path": "integration/fx-team", 05:03:26 INFO - "revision": "444097473d1a78553a360b82a2d123cfad306492", 05:03:26 INFO - "stage_platform": "linux64-pgo", 05:03:26 INFO - "builduid": "4650683aa9ec4810bd902957b8b630b0", 05:03:26 INFO - "slavebuilddir": "test" 05:03:26 INFO - } 05:03:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:03:26 INFO - Running post-action listener: _resource_record_post_action 05:03:26 INFO - ##### 05:03:26 INFO - ##### Running download-and-extract step. 05:03:26 INFO - ##### 05:03:26 INFO - Running pre-action listener: _resource_record_pre_action 05:03:26 INFO - Running main action method: download_and_extract 05:03:26 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:26 INFO - https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:03:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/test_packages.json 05:03:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/test_packages.json 05:03:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:03:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:03:28 INFO - Downloaded 1302 bytes. 05:03:28 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:03:28 INFO - Using the following test package requirements: 05:03:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:03:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:28 INFO - u'jsshell-linux-x86_64.zip'], 05:03:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:03:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:03:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:03:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:03:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:03:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:03:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:03:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:03:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:28 INFO - https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:03:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:03:30 INFO - Downloaded 24097761 bytes. 05:03:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:03:30 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:30 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:03:31 INFO - Return code: 0 05:03:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:31 INFO - https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:03:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:03:33 INFO - Downloaded 24097761 bytes. 05:03:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 05:03:33 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:03:33 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:03:34 INFO - Return code: 0 05:03: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')]} 05:03:34 INFO - https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:03:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:03:35 INFO - Downloaded 11132285 bytes. 05:03:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 05:03:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:03:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:03:36 INFO - Return code: 0 05:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:36 INFO - https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:03:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:03:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:03:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:03:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:03:37 INFO - Downloaded 55073732 bytes. 05:03:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:03:37 INFO - mkdir: /builds/slave/test-pgo/properties 05:03:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:03:37 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:03:37 INFO - Contents: 05:03:37 INFO - build_url:https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:03:37 INFO - Running post-action listener: _resource_record_post_action 05:03:37 INFO - Running post-action listener: set_extra_try_arguments 05:03:37 INFO - ##### 05:03:37 INFO - ##### Running populate-webroot step. 05:03:37 INFO - ##### 05:03:37 INFO - Running pre-action listener: _resource_record_pre_action 05:03:37 INFO - Running main action method: populate_webroot 05:03:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:03:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:03:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:03:37 INFO - '--tppagecycles', 05:03:37 INFO - '7'], 05:03:37 INFO - 'tests': ['tsvgm']}}, 05:03:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:03:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:03:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:03:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:03:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:03:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:03:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:37 INFO - 'talos_options': ['--e10s'], 05:03:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:03:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:37 INFO - 'tests': ['damp', 'tps']}, 05:03:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:37 INFO - 'talos_options': ['--e10s'], 05:03:37 INFO - 'tests': ['damp', 'tps']}, 05:03:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:03:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:03:37 INFO - 'other': {'tests': ['a11yr', 05:03:37 INFO - 'ts_paint', 05:03:37 INFO - 'tpaint', 05:03:37 INFO - 'sessionrestore', 05:03:37 INFO - 'sessionrestore_no_auto_restore']}, 05:03:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:03:37 INFO - 'tests': ['a11yr', 05:03:37 INFO - 'ts_paint', 05:03:37 INFO - 'tpaint', 05:03:37 INFO - 'sessionrestore', 05:03:37 INFO - 'sessionrestore_no_auto_restore']}, 05:03:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:03:37 INFO - 'tests': ['a11yr', 05:03:37 INFO - 'ts_paint', 05:03:37 INFO - 'tpaint', 05:03:37 INFO - 'sessionrestore', 05:03:37 INFO - 'sessionrestore_no_auto_restore']}, 05:03:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:03:37 INFO - 'tests': ['a11yr', 05:03:37 INFO - 'ts_paint', 05:03:37 INFO - 'tpaint', 05:03:37 INFO - 'sessionrestore', 05:03:37 INFO - 'sessionrestore_no_auto_restore']}, 05:03:37 INFO - 'other_l64': {'tests': ['a11yr', 05:03:37 INFO - 'ts_paint', 05:03:37 INFO - 'tpaint', 05:03:37 INFO - 'sessionrestore', 05:03:37 INFO - 'sessionrestore_no_auto_restore']}, 05:03:37 INFO - 'other_nol64': {'tests': ['a11yr', 05:03:37 INFO - 'ts_paint', 05:03:37 INFO - 'tpaint', 05:03:37 INFO - 'sessionrestore', 05:03:37 INFO - 'sessionrestore_no_auto_restore']}, 05:03:37 INFO - 'svgr': {'tests': ['tsvgx', 05:03:37 INFO - 'tsvgr_opacity', 05:03:37 INFO - 'tart', 05:03:37 INFO - 'tscrollx', 05:03:37 INFO - 'cart']}, 05:03:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:03:37 INFO - 'tests': ['tsvgx', 05:03:37 INFO - 'tsvgr_opacity', 05:03:37 INFO - 'tart', 05:03:37 INFO - 'tscrollx', 05:03:37 INFO - 'cart']}, 05:03:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:37 INFO - 'tests': ['tp5o']}, 05:03:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:37 INFO - 'talos_options': ['--e10s'], 05:03:37 INFO - 'tests': ['tp5o']}, 05:03:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:37 INFO - 'talos_options': ['--xperf_path', 05:03:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:37 INFO - 'tests': ['tp5n']}, 05:03:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:03:37 INFO - 'talos_options': ['--e10s', 05:03:37 INFO - '--xperf_path', 05:03:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:03:37 INFO - 'tests': ['tp5n']}}, 05:03:37 INFO - 'talos.zip': {'path': '', 05:03:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:03:37 INFO - Running post-action listener: _resource_record_post_action 05:03:37 INFO - ##### 05:03:37 INFO - ##### Running create-virtualenv step. 05:03:37 INFO - ##### 05:03:37 INFO - Running pre-action listener: _resource_record_pre_action 05:03:37 INFO - Running main action method: create_virtualenv 05:03:37 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:03:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:03:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:03:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:03:37 INFO - Using real prefix '/usr' 05:03:37 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:03:38 INFO - Installing distribute.............................................................................................................................................................................................done. 05:03:40 INFO - Installing pip.................done. 05:03:40 INFO - Return code: 0 05:03:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:40 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 0x7f35e7678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857660>, '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 0x1858560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858a10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:03:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:03:40 INFO - Using env: {'DISPLAY': ':0', 05:03:40 INFO - 'HOME': '/home/cltbld', 05:03:40 INFO - 'LANG': 'en_US.UTF-8', 05:03:40 INFO - 'LANGUAGE': 'en_US:en', 05:03:40 INFO - 'LOGNAME': 'cltbld', 05:03:40 INFO - 'MAIL': '/var/mail/cltbld', 05:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:40 INFO - 'MOZ_NO_REMOTE': '1', 05:03:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:40 INFO - 'NO_EM_RESTART': '1', 05:03:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:40 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:40 INFO - 'SHELL': '/bin/bash', 05:03:40 INFO - 'SHLVL': '1', 05:03:40 INFO - 'TERM': 'linux', 05:03:40 INFO - 'TMOUT': '86400', 05:03:40 INFO - 'USER': 'cltbld', 05:03:40 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 05:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:40 INFO - '_': '/tools/buildbot/bin/python'} 05:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:03:40 INFO - Cleaning up... 05:03:40 INFO - Return code: 0 05:03:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:40 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 0x7f35e7678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857660>, '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 0x1858560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858a10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:40 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:03:40 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:03:40 INFO - Using env: {'DISPLAY': ':0', 05:03:40 INFO - 'HOME': '/home/cltbld', 05:03:40 INFO - 'LANG': 'en_US.UTF-8', 05:03:40 INFO - 'LANGUAGE': 'en_US:en', 05:03:40 INFO - 'LOGNAME': 'cltbld', 05:03:40 INFO - 'MAIL': '/var/mail/cltbld', 05:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:40 INFO - 'MOZ_NO_REMOTE': '1', 05:03:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:40 INFO - 'NO_EM_RESTART': '1', 05:03:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:40 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:40 INFO - 'SHELL': '/bin/bash', 05:03:40 INFO - 'SHLVL': '1', 05:03:40 INFO - 'TERM': 'linux', 05:03:40 INFO - 'TMOUT': '86400', 05:03:40 INFO - 'USER': 'cltbld', 05:03:40 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 05:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:40 INFO - '_': '/tools/buildbot/bin/python'} 05:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:40 INFO - Downloading/unpacking psutil>=0.7.1 05:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:42 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:03:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:03:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:03:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:42 INFO - Installing collected packages: psutil 05:03:42 INFO - Running setup.py install for psutil 05:03:42 INFO - building 'psutil._psutil_linux' extension 05:03:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:03:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:03:42 INFO - building 'psutil._psutil_posix' extension 05:03:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:03:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:03:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:03:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:03:42 INFO - Successfully installed psutil 05:03:42 INFO - Cleaning up... 05:03:43 INFO - Return code: 0 05:03:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:43 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 0x7f35e7678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857660>, '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 0x1858560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858a10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:43 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:03:43 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:03:43 INFO - Using env: {'DISPLAY': ':0', 05:03:43 INFO - 'HOME': '/home/cltbld', 05:03:43 INFO - 'LANG': 'en_US.UTF-8', 05:03:43 INFO - 'LANGUAGE': 'en_US:en', 05:03:43 INFO - 'LOGNAME': 'cltbld', 05:03:43 INFO - 'MAIL': '/var/mail/cltbld', 05:03:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:43 INFO - 'MOZ_NO_REMOTE': '1', 05:03:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:43 INFO - 'NO_EM_RESTART': '1', 05:03:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:43 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:43 INFO - 'SHELL': '/bin/bash', 05:03:43 INFO - 'SHLVL': '1', 05:03:43 INFO - 'TERM': 'linux', 05:03:43 INFO - 'TMOUT': '86400', 05:03:43 INFO - 'USER': 'cltbld', 05:03:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 05:03:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:43 INFO - '_': '/tools/buildbot/bin/python'} 05:03:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:03:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:03:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:03:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:03:44 INFO - Installing collected packages: mozsystemmonitor 05:03:44 INFO - Running setup.py install for mozsystemmonitor 05:03:45 INFO - Successfully installed mozsystemmonitor 05:03:45 INFO - Cleaning up... 05:03:45 INFO - Return code: 0 05:03:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:45 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 0x7f35e7678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857660>, '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 0x1858560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858a10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:45 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:03:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:03:45 INFO - Using env: {'DISPLAY': ':0', 05:03:45 INFO - 'HOME': '/home/cltbld', 05:03:45 INFO - 'LANG': 'en_US.UTF-8', 05:03:45 INFO - 'LANGUAGE': 'en_US:en', 05:03:45 INFO - 'LOGNAME': 'cltbld', 05:03:45 INFO - 'MAIL': '/var/mail/cltbld', 05:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:45 INFO - 'MOZ_NO_REMOTE': '1', 05:03:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:45 INFO - 'NO_EM_RESTART': '1', 05:03:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:45 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:45 INFO - 'SHELL': '/bin/bash', 05:03:45 INFO - 'SHLVL': '1', 05:03:45 INFO - 'TERM': 'linux', 05:03:45 INFO - 'TMOUT': '86400', 05:03:45 INFO - 'USER': 'cltbld', 05:03:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 05:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:45 INFO - '_': '/tools/buildbot/bin/python'} 05:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:45 INFO - Downloading/unpacking blobuploader==1.2.4 05:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:03:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:03:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:03:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:03:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:03:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:47 INFO - Downloading docopt-0.6.1.tar.gz 05:03:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:03:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:03:47 INFO - Installing collected packages: blobuploader, requests, docopt 05:03:47 INFO - Running setup.py install for blobuploader 05:03:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:03:47 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:03:47 INFO - Running setup.py install for requests 05:03:48 INFO - Running setup.py install for docopt 05:03:48 INFO - Successfully installed blobuploader requests docopt 05:03:48 INFO - Cleaning up... 05:03:48 INFO - Return code: 0 05:03:48 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:03: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')]} 05:03:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03: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')]} 05:03:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:48 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 0x7f35e7678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857660>, '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 0x1858560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858a10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:48 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:03:48 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:48 INFO - Using env: {'DISPLAY': ':0', 05:03:48 INFO - 'HOME': '/home/cltbld', 05:03:48 INFO - 'LANG': 'en_US.UTF-8', 05:03:48 INFO - 'LANGUAGE': 'en_US:en', 05:03:48 INFO - 'LOGNAME': 'cltbld', 05:03:48 INFO - 'MAIL': '/var/mail/cltbld', 05:03:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:48 INFO - 'MOZ_NO_REMOTE': '1', 05:03:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:48 INFO - 'NO_EM_RESTART': '1', 05:03:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:48 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:48 INFO - 'SHELL': '/bin/bash', 05:03:48 INFO - 'SHLVL': '1', 05:03:48 INFO - 'TERM': 'linux', 05:03:48 INFO - 'TMOUT': '86400', 05:03:48 INFO - 'USER': 'cltbld', 05:03:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 05:03:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:48 INFO - '_': '/tools/buildbot/bin/python'} 05:03:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:03:48 INFO - Running setup.py (path:/tmp/pip-j9rCSC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:03:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:03:48 INFO - Running setup.py (path:/tmp/pip-szbZ_B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:03:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:03:48 INFO - Running setup.py (path:/tmp/pip-qqTvGt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:03:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:03:48 INFO - Running setup.py (path:/tmp/pip-t8I1QK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:03:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:03:48 INFO - Running setup.py (path:/tmp/pip-qWS6tg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:03:48 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:03:48 INFO - Running setup.py (path:/tmp/pip-a7Er2e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:03:49 INFO - Running setup.py (path:/tmp/pip-_CoLjF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:03:49 INFO - Running setup.py (path:/tmp/pip-f5nlth-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:03:49 INFO - Running setup.py (path:/tmp/pip-pX7ddi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:03:49 INFO - Running setup.py (path:/tmp/pip-8fLGs2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:03:49 INFO - Running setup.py (path:/tmp/pip-KoKl3J-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:03:49 INFO - Running setup.py (path:/tmp/pip-t8zzHs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:03:49 INFO - Running setup.py (path:/tmp/pip-eCYCTA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:03:49 INFO - Running setup.py (path:/tmp/pip-4yLfbZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:03:49 INFO - Running setup.py (path:/tmp/pip-5MuMnW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:03:49 INFO - Running setup.py (path:/tmp/pip-ZiWoV_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:03:49 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:03:49 INFO - Running setup.py (path:/tmp/pip-armRMS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:03:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:03:49 INFO - Running setup.py install for manifestparser 05:03:49 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:03:49 INFO - Running setup.py install for mozcrash 05:03:50 INFO - Running setup.py install for mozdebug 05:03:50 INFO - Running setup.py install for mozdevice 05:03:50 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:03:50 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:03:50 INFO - Running setup.py install for mozfile 05:03:50 INFO - Running setup.py install for mozhttpd 05:03:50 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:03:50 INFO - Running setup.py install for mozinfo 05:03:50 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:03:50 INFO - Running setup.py install for mozInstall 05:03:50 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:03:50 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:03:50 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:03:50 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:03:50 INFO - Running setup.py install for mozleak 05:03:50 INFO - Running setup.py install for mozlog 05:03:50 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:03:50 INFO - Running setup.py install for moznetwork 05:03:50 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:03:50 INFO - Running setup.py install for mozprocess 05:03:51 INFO - Running setup.py install for mozprofile 05:03:51 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:03:51 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:03:51 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:03:51 INFO - Running setup.py install for mozrunner 05:03:51 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:03:51 INFO - Running setup.py install for mozscreenshot 05:03:51 INFO - Running setup.py install for moztest 05:03:51 INFO - Running setup.py install for mozversion 05:03:51 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:03:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:03:51 INFO - Cleaning up... 05:03:51 INFO - Return code: 0 05:03:51 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f35e7678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857660>, '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 0x1858560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858a10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:03:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:51 INFO - Using env: {'DISPLAY': ':0', 05:03:51 INFO - 'HOME': '/home/cltbld', 05:03:51 INFO - 'LANG': 'en_US.UTF-8', 05:03:51 INFO - 'LANGUAGE': 'en_US:en', 05:03:51 INFO - 'LOGNAME': 'cltbld', 05:03:51 INFO - 'MAIL': '/var/mail/cltbld', 05:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:51 INFO - 'MOZ_NO_REMOTE': '1', 05:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:51 INFO - 'NO_EM_RESTART': '1', 05:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:51 INFO - 'SHELL': '/bin/bash', 05:03:51 INFO - 'SHLVL': '1', 05:03:51 INFO - 'TERM': 'linux', 05:03:51 INFO - 'TMOUT': '86400', 05:03:51 INFO - 'USER': 'cltbld', 05:03:51 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 05:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:51 INFO - '_': '/tools/buildbot/bin/python'} 05:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:03:51 INFO - Running setup.py (path:/tmp/pip-9fzYdZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:03:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:03:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:03:51 INFO - Running setup.py (path:/tmp/pip-5Wq6Bs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:03:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:03:51 INFO - Running setup.py (path:/tmp/pip-MiVSP8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:03:52 INFO - Running setup.py (path:/tmp/pip-DJ1aRn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:03:52 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)) 05:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:03:52 INFO - Running setup.py (path:/tmp/pip-chiuUH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:03:52 INFO - Running setup.py (path:/tmp/pip-5rNbnh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:03:52 INFO - Running setup.py (path:/tmp/pip-7G3wOo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:03:52 INFO - Running setup.py (path:/tmp/pip-nvc9js-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:03:52 INFO - Running setup.py (path:/tmp/pip-dhz37n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:03:52 INFO - Running setup.py (path:/tmp/pip-x8x3RZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:03:52 INFO - Running setup.py (path:/tmp/pip-YYHhai-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:03:52 INFO - Running setup.py (path:/tmp/pip-8STgEE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:03:52 INFO - Running setup.py (path:/tmp/pip-nIXiaC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:03:52 INFO - Running setup.py (path:/tmp/pip-iTa251-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:03:52 INFO - Running setup.py (path:/tmp/pip-LzuCSq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:03:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:03:52 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:03:52 INFO - Running setup.py (path:/tmp/pip-Zo3WTy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:03:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:03:53 INFO - Running setup.py (path:/tmp/pip-sYorhP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:03:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:03:53 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)) 05:03:53 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)) 05:03:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:54 INFO - Downloading blessings-1.5.1.tar.gz 05:03:54 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:03:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:03:54 INFO - Installing collected packages: blessings 05:03:54 INFO - Running setup.py install for blessings 05:03:54 INFO - Successfully installed blessings 05:03:54 INFO - Cleaning up... 05:03:55 INFO - Return code: 0 05:03:55 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:03:55 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:03:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:03:55 INFO - Reading from file tmpfile_stdout 05:03:55 INFO - Current package versions: 05:03:55 INFO - argparse == 1.2.1 05:03:55 INFO - blessings == 1.5.1 05:03:55 INFO - blobuploader == 1.2.4 05:03:55 INFO - docopt == 0.6.1 05:03:55 INFO - manifestparser == 1.1 05:03:55 INFO - mozInstall == 1.12 05:03:55 INFO - mozcrash == 0.16 05:03:55 INFO - mozdebug == 0.1 05:03:55 INFO - mozdevice == 0.47 05:03:55 INFO - mozfile == 1.2 05:03:55 INFO - mozhttpd == 0.7 05:03:55 INFO - mozinfo == 0.9 05:03:55 INFO - mozleak == 0.1 05:03:55 INFO - mozlog == 3.1 05:03:55 INFO - moznetwork == 0.27 05:03:55 INFO - mozprocess == 0.22 05:03:55 INFO - mozprofile == 0.28 05:03:55 INFO - mozrunner == 6.11 05:03:55 INFO - mozscreenshot == 0.1 05:03:55 INFO - mozsystemmonitor == 0.0 05:03:55 INFO - moztest == 0.7 05:03:55 INFO - mozversion == 1.4 05:03:55 INFO - psutil == 3.1.1 05:03:55 INFO - requests == 1.2.3 05:03:55 INFO - wsgiref == 0.1.2 05:03:55 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f35e7678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857660>, '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 0x1858560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858a10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:03:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:03:55 INFO - Using env: {'DISPLAY': ':0', 05:03:55 INFO - 'HOME': '/home/cltbld', 05:03:55 INFO - 'LANG': 'en_US.UTF-8', 05:03:55 INFO - 'LANGUAGE': 'en_US:en', 05:03:55 INFO - 'LOGNAME': 'cltbld', 05:03:55 INFO - 'MAIL': '/var/mail/cltbld', 05:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:55 INFO - 'MOZ_NO_REMOTE': '1', 05:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:55 INFO - 'NO_EM_RESTART': '1', 05:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:55 INFO - 'SHELL': '/bin/bash', 05:03:55 INFO - 'SHLVL': '1', 05:03:55 INFO - 'TERM': 'linux', 05:03:55 INFO - 'TMOUT': '86400', 05:03:55 INFO - 'USER': 'cltbld', 05:03:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 05:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:55 INFO - '_': '/tools/buildbot/bin/python'} 05:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:03:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:03:55 INFO - Cleaning up... 05:03:55 INFO - Return code: 0 05:03:55 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:55 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f35e7678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857660>, '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 0x1858560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858a10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:55 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:03:55 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:03:55 INFO - Using env: {'DISPLAY': ':0', 05:03:55 INFO - 'HOME': '/home/cltbld', 05:03:55 INFO - 'LANG': 'en_US.UTF-8', 05:03:55 INFO - 'LANGUAGE': 'en_US:en', 05:03:55 INFO - 'LOGNAME': 'cltbld', 05:03:55 INFO - 'MAIL': '/var/mail/cltbld', 05:03:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:55 INFO - 'MOZ_NO_REMOTE': '1', 05:03:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:55 INFO - 'NO_EM_RESTART': '1', 05:03:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:55 INFO - 'SHELL': '/bin/bash', 05:03:55 INFO - 'SHLVL': '1', 05:03:55 INFO - 'TERM': 'linux', 05:03:55 INFO - 'TMOUT': '86400', 05:03:55 INFO - 'USER': 'cltbld', 05:03:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 05:03:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:55 INFO - '_': '/tools/buildbot/bin/python'} 05:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:55 INFO - Downloading/unpacking jsonschema 05:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:03:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:03:57 INFO - Downloading/unpacking functools32 (from jsonschema) 05:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:57 INFO - Downloading functools32-3.2.3-2.tar.gz 05:03:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:03:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:03:57 INFO - warning: no files found matching '*.txt' 05:03:57 INFO - no previously-included directories found matching 'build' 05:03:57 INFO - no previously-included directories found matching 'dist' 05:03:57 INFO - no previously-included directories found matching '.git*' 05:03:57 INFO - Installing collected packages: jsonschema, functools32 05:03:57 INFO - Running setup.py install for functools32 05:03:57 INFO - warning: no files found matching '*.txt' 05:03:57 INFO - no previously-included directories found matching 'build' 05:03:57 INFO - no previously-included directories found matching 'dist' 05:03:57 INFO - no previously-included directories found matching '.git*' 05:03:57 INFO - Successfully installed jsonschema functools32 05:03:57 INFO - Cleaning up... 05:03:57 INFO - Return code: 0 05:03:57 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:03:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:03:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:03:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:03:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f35e7678f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16fb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c8480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1857660>, '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 0x1858560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858a10>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:03:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:03:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:03:57 INFO - Using env: {'DISPLAY': ':0', 05:03:57 INFO - 'HOME': '/home/cltbld', 05:03:57 INFO - 'LANG': 'en_US.UTF-8', 05:03:57 INFO - 'LANGUAGE': 'en_US:en', 05:03:57 INFO - 'LOGNAME': 'cltbld', 05:03:57 INFO - 'MAIL': '/var/mail/cltbld', 05:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:03:57 INFO - 'MOZ_NO_REMOTE': '1', 05:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:03:57 INFO - 'NO_EM_RESTART': '1', 05:03:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:03:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:03:57 INFO - 'SHELL': '/bin/bash', 05:03:57 INFO - 'SHLVL': '1', 05:03:57 INFO - 'TERM': 'linux', 05:03:57 INFO - 'TMOUT': '86400', 05:03:57 INFO - 'USER': 'cltbld', 05:03:57 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 05:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:03:57 INFO - '_': '/tools/buildbot/bin/python'} 05:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:03:58 INFO - Downloading/unpacking flake8 05:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:03:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:03:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:03:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:03: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 05:03: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 05:03: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 05:03: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 05:03: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 05:03: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 05:03:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:03:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:03:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:03: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 05:03: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 05:03: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 05:03: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 05:03: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 05:03: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 05:04:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:04:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:04:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:04:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:04:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:04:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:04:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:04:00 INFO - no previously-included directories found matching 'docs/_build' 05:04:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:04:00 INFO - Running setup.py install for pep8 05:04:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:04:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:04:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:04:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:04:00 INFO - no previously-included directories found matching 'docs/_build' 05:04:00 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:04:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:04:00 INFO - Cleaning up... 05:04:00 INFO - Return code: 0 05:04:00 INFO - Running post-action listener: _resource_record_post_action 05:04:00 INFO - Running post-action listener: _start_resource_monitoring 05:04:00 INFO - Starting resource monitoring. 05:04:00 INFO - ##### 05:04:00 INFO - ##### Running install step. 05:04:00 INFO - ##### 05:04:00 INFO - Running pre-action listener: _resource_record_pre_action 05:04:00 INFO - Running main action method: install 05:04:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:04:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:04:00 INFO - Reading from file tmpfile_stdout 05:04:00 INFO - Detecting whether we're running mozinstall >=1.0... 05:04:00 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:04:00 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:04:01 INFO - Reading from file tmpfile_stdout 05:04:01 INFO - Output received: 05:04:01 INFO - Usage: mozinstall [options] installer 05:04:01 INFO - Options: 05:04:01 INFO - -h, --help show this help message and exit 05:04:01 INFO - -d DEST, --destination=DEST 05:04:01 INFO - Directory to install application into. [default: 05:04:01 INFO - "/builds/slave/test-pgo"] 05:04:01 INFO - --app=APP Application being installed. [default: firefox] 05:04:01 INFO - mkdir: /builds/slave/test-pgo/build/application 05:04:01 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:04:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:04:16 INFO - Reading from file tmpfile_stdout 05:04:16 INFO - Output received: 05:04:16 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:04:16 INFO - Running post-action listener: _resource_record_post_action 05:04:16 INFO - ##### 05:04:16 INFO - ##### Running run-tests step. 05:04:16 INFO - ##### 05:04:16 INFO - Running pre-action listener: _resource_record_pre_action 05:04:16 INFO - Running main action method: run_tests 05:04:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:04:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:04:16 INFO - Python 2.7.3 05:04:16 INFO - Return code: 0 05:04:16 INFO - grabbing minidump binary from tooltool 05:04:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:04:16 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 0x1857660>, '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 0x1858560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1858a10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:04:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:04:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:04:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:04:16 INFO - Return code: 0 05:04:16 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:04:16 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:04:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:04:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:04:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:04:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:04:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:04:17 INFO - Return code: 0 05:04:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:04:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:04:17 INFO - Using env: {'DISPLAY': ':0', 05:04:17 INFO - 'HOME': '/home/cltbld', 05:04:17 INFO - 'LANG': 'en_US.UTF-8', 05:04:17 INFO - 'LANGUAGE': 'en_US:en', 05:04:17 INFO - 'LOGNAME': 'cltbld', 05:04:17 INFO - 'MAIL': '/var/mail/cltbld', 05:04:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:04:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:04:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:17 INFO - 'MOZ_NO_REMOTE': '1', 05:04:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:04:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:17 INFO - 'NO_EM_RESTART': '1', 05:04:17 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:04:17 INFO - 'PWD': '/builds/slave/test-pgo', 05:04:17 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:04:17 INFO - 'SHELL': '/bin/bash', 05:04:17 INFO - 'SHLVL': '1', 05:04:17 INFO - 'TERM': 'linux', 05:04:17 INFO - 'TMOUT': '86400', 05:04:17 INFO - 'USER': 'cltbld', 05:04:17 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511', 05:04:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:17 INFO - '_': '/tools/buildbot/bin/python'} 05:04:17 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:04:18 INFO - mozversion application_buildid: 20160106023011 05:04:18 INFO - mozversion application_changeset: 444097473d1a78553a360b82a2d123cfad306492 05:04:18 INFO - mozversion application_display_name: Nightly 05:04:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:04:18 INFO - mozversion application_name: Firefox 05:04:18 INFO - mozversion application_remotingname: firefox 05:04:18 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:04:18 INFO - mozversion application_vendor: Mozilla 05:04:18 INFO - mozversion application_version: 46.0a1 05:04:18 INFO - mozversion platform_buildid: 20160106023011 05:04:18 INFO - mozversion platform_changeset: 444097473d1a78553a360b82a2d123cfad306492 05:04:18 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:04:18 INFO - mozversion platform_version: 46.0a1 05:04:18 INFO - using testdate: 1452085458 05:04:18 INFO - actual date: 1452085458 05:04:18 INFO - starting webserver on 'localhost:36128' 05:04:18 INFO - SUITE-START | Running 3 tests 05:04:18 INFO - TEST-START | dromaeo_css 05:04:18 INFO - operating with platform_type : linux_ 05:04:18 INFO - Initialising browser for dromaeo_css test... 05:04:18 INFO - TEST-INFO | started process 11526 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ_6732/profile http://localhost:36128/getInfo.html) 05:04:22 INFO - PROCESS | 11526 | __metrics Screen width/height:1600/1200 05:04:22 INFO - PROCESS | 11526 | colorDepth:24 05:04:22 INFO - PROCESS | 11526 | Browser inner width/height: 1024/697 05:04:22 INFO - PROCESS | 11526 | __metrics 05:04:22 INFO - PROCESS | 11526 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:04:22 INFO - PROCESS | 11526 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:04:22 INFO - PROCESS | 11526 | 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. 05:04:23 INFO - TEST-INFO | 11526: exit 0 05:04:23 INFO - Browser initialized. 05:04:23 INFO - Running cycle 1/1 for dromaeo_css test... 05:04:23 INFO - TEST-INFO | started process 11622 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ_6732/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:34 INFO - PROCESS | 11622 | RSS: Main: 147726336 05:04:34 INFO - PROCESS | 11622 | 05:05:26 INFO - PROCESS | 11622 | 1452085526385 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:07:34 INFO - PROCESS | 11622 | Cycle 1(1): loaded http://localhost:36128/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36128/tests/dromaeo/cssquery-ext.html) 05:07:35 INFO - PROCESS | 11622 | RSS: Main: 258539520 05:07:35 INFO - PROCESS | 11622 | 05:10:38 INFO - PROCESS | 11622 | Cycle 1(1): loaded http://localhost:36128/tests/dromaeo/cssquery-ext.html (next: http://localhost:36128/tests/dromaeo/cssquery-jquery.html) 05:10:39 INFO - PROCESS | 11622 | RSS: Main: 237903872 05:10:39 INFO - PROCESS | 11622 | 05:13:41 INFO - PROCESS | 11622 | Cycle 1(1): loaded http://localhost:36128/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36128/tests/dromaeo/cssquery-mootools.html) 05:13:41 INFO - PROCESS | 11622 | RSS: Main: 231698432 05:13:41 INFO - PROCESS | 11622 | 05:16:43 INFO - PROCESS | 11622 | Cycle 1(1): loaded http://localhost:36128/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36128/tests/dromaeo/cssquery-prototype.html) 05:16:44 INFO - PROCESS | 11622 | RSS: Main: 214331392 05:16:44 INFO - PROCESS | 11622 | 05:19:46 INFO - PROCESS | 11622 | Cycle 1(1): loaded http://localhost:36128/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36128/tests/dromaeo/cssquery-yui.html) 05:19:47 INFO - PROCESS | 11622 | RSS: Main: 222142464 05:19:47 INFO - PROCESS | 11622 | 05:22:49 INFO - PROCESS | 11622 | Cycle 1(1): loaded http://localhost:36128/tests/dromaeo/cssquery-yui.html (next: http://localhost:36128/tests/dromaeo/cssquery-dojo.html) 05:22:49 INFO - PROCESS | 11622 | RSS: Main: 262811648 05:22:49 INFO - PROCESS | 11622 | 05:22:49 INFO - PROCESS | 11622 | __start_tp_report 05:22:49 INFO - PROCESS | 11622 | _x_x_mozilla_page_load 05:22:49 INFO - PROCESS | 11622 | _x_x_mozilla_page_load_details 05:22:49 INFO - PROCESS | 11622 | |i|pagename|runs| 05:22:49 INFO - PROCESS | 11622 | |0;dojo.html;3079.4610943084963;3150.086474922273;3190.8404579771022;3198.2803869129434;3208;4935.580475659564;5061.139606266935;5095.847124586259;5103.744812759361;5138.460461651524;4953.3560637117125;4995.800167993276;5010.599152067835;5013.498650134985;5058.69647821131;4450.132224216279;4613.6078433333205;4636.907261854761;4678.1813182692895;4806.687565308262;4544.636429085665;4617.191991401508;4769.18923782956;4769.356136921523;4792.616590672737;4567.794449249792;4640.60554852838;4644.814207431698;4655.720656760588;4658.464276608166;4674.953250467486;4693.389859318267;4717.811287548494;4723.197056500403;4756.334113224151;4461.24158892989;4588.2888152336445;4710.3641008463765;4722.031983443386;4729.314249433813;4939.061578300148;5001.3998320201445;5007.549320561167;5008.198688209905;5054.1660625996665;5484.890302193974;5506.256655351516;5513.8345849624575;5529.30883639545;5560.277163968699;5349.5720342372515;5474.835754927359;5484.61607687462;5536.557075433956;5541;5156.664816786934;5182.585393168538;5188.558972487343;5190.195519694454;5200.817971370984;5685.914711279334;5751.942480575224;5757.050086735725;5765.818007308491;5766.4233576642;5230.37235531731;5329.067413202674;5334.51989320963;5392.892142157135;5523.392426833045;5510.779568817203;5541.833744987657;5545.195946587723;5594.300712410949;5600.663960162403;5508.394076651565;5509.3664228613425;5512.145617429305;5523.834284971457;5529.668219906818;5327.467253274719;5428.348598168245;5475.616706830484;5527.889442211133;5599.972000140055;4289.785510724451;4334.349847522897;4366.890827729332;4370.890727731832;4376;3874.49631547897;3894.1043559981363;3897.61023897608;3927.7839718815167;3935.8032098394965;5006.224035274538;5172.844814655567;5213.139831927765;5215.452377500384;5225.503577160163;5436.157395603688;5479.04116779562;5487.122060470306;5589.552835773128;5631.436856314336;5183.714895680699;5186.559142472856;5187.403448603459;5193.3767947845745;5225.346831646044;4770.212914869077;4777.546133117348;4786.1863483207935;4794.041191761662;4829.323894654751;5477.835664930059;5565.554755619541;5623.550115990793;5698.031334673115;5706.828795136153;5449.836504904859;5513.283273174462;5522.5858060644805;5565.998120338216;5571.60998730085;5660.29246344207;5667.546596272371;5668;5675.7445914933105;5678.914816277676;5313.9468605315;5382.111951527954;5396.055690254111;5409.891802163856;5439.646422982493;5339.4126646068125;5518.668879867221;5579.8047068354035;5582.804601838916;5601.607887448003;5355.062863998863;5360.571154307568;5361.195820626937;5361.785528578969;5362.302900622894;5207.1668533036045;5308.893822123613;5322.494363035506;5329.094054010905;5384.838454846361;5175.430702622783;5222.7127507987425;5303.151495760814;5320.334958130234;5344.6525975813;5305.859240263362;5314.3091398117995;5341.278927344759;5358.678479291255;5395;5058.215976523645;5208.0365132450615;5209.140491818807;5211.348581427322;5226.555742761908 05:22:49 INFO - PROCESS | 11622 | |1;ext.html;524.9212618107284;530.284116442802;531.529596307268;551.2723205368914;560.5039540007092;29076.127716168496;29739.851300743492;29773.106806795804;36897.26205475889;37696.81151594245;40863.59136408635;41209.58790412095;41211.79394103033;41213;41267.58732412675;8401.075881653029;8558.400911936136;8561.272291855168;8567.828643427129;8568.957155214215;7403.592802395866;7522.2101679323705;10102.59589616418;10298.17614590831;10315.638952636658;10128.54421551032;10204.591816327375;10236.539355728974;10236.795264094713;10241.231907606922;7577.772666820004;7731.149573546962;9946.15457686094;10084.042016008467;10084.092431681183;7231.529950553249;7324.1577218620005;7325.560466372035;10139.79720405595;10354.17166626668;37068;37510;37553;37576.24847503062;37590.812045939594;3174.68253174683;3607.314610224049;3612.187257866985;3856.5564960029674;3932.390479475686;28197.295067623472;28656.856715716498;29183.41633167346;29244.415111697646;30061.849690751624;3945;4050.9189816203807;4056.3104272273786;4108.26051310764;4147.274227010261;259736;259963;262411;262744.6862765693;262921;51522;52683;59893.70053149707;60534.39465605376;60552.39447605467;64212;65118.34881651123;65144.34855651478;65157.67421162864;65208;12305;12467.189632673848;12527.248365098123;12588.370581471074;12604.11771176009;10105.9494702526;10126.848097278547;10158.085772280383;10164.237682173867;10185.847212291821;20099.29652462186;20465.18139274442;20509.58980820405;20596;20747.481312966996;7748.92251077482;7833.764987050397;7834.4907581007055;7919;7947.410517896444;912.2838571721167;956.3401253135314;1034.2915103154364;1061.2889364126054;1070.6895000449938;28653;28885;28928.421431571252;29276;29409.852950735538;1004.6785028790863;1042.2339580408393;1104.6685994201707;1120.2438354110943;1180.2682336950973;14898.776518352233;15144.16707081121;15195.772063419057;15424.614384640474;15505.457308994131;326125;329506;331027;333069;333151;51965.48034519606;52192.47807521952;52776.47223527792;52808.47191528112;52921.470785291654;1347.5081595217675;1347.7304539092024;1348.4067010515341;1348.5187255450019;1354.674878029266;27806.582901256093;28522.42955140927;29136.27159321034;29150.27124321824;29238;49467;50074.74962625309;50218;50314;50412.747936260086;250450;252165;252265;252310;253536;36021;36330.818345908105;38870.6112938867;42563.29746810093;42966.355504666826;38711;41812.163756725306;42855;43348.13303733845;43929.34105988477;35944;36395;36534.269314613026;37554;37704.245915082094;29525.47981140391;36222.275554489286;37117.20077448931;37375.813120934225;37490;32455.513167302983;33549.322533873696;33984.490232646036;34295.48556771601;34320.627174912726;33268.66731332656;34701.47947780735;35667.46498802572;37463.62536374601;37624.24751505009;23579.64630530509;23775.286741397787;23867;24108.51782964366;24249.63625545583 05:22:49 INFO - PROCESS | 11622 | |2;jquery.html;346.27801034842355;356.8768774772702;358.46230654018973;358.54643875497493;359.05926472641653;14159.22124283164;14454.277286135704;16365.345386184554;16628.50114496564;17236.74144887826;15680.294386752596;15698.921505392456;16252.75620865688;16277.348906043744;16305.103219322933;4636.350910872472;4808.759562021903;4813.78337974792;4816.566509014188;4819.42166939966;3801.923961520768;3885;4787.449443314012;5299.417064122943;5512.39363669996;5449.6375906023495;5459.235707001023;5460.945390546083;5472.781088756445;5486.561075114001;5370.570354371641;5907;5919.200907877467;5940.04959206527;5964.254468191476;5242.580593552507;5278.392984806758;5294;5297.973510132463;5310.0441920454305;12338.876611233862;13233.404496797668;13248.138870973356;13259.138156019828;15515.68116710081;1953.7460130183126;1996.8103030212108;2057.9794202057938;2063.546019875625;2075.865068770525;9451;9729.951350243204;9782.315237933348;10770.784584308349;10941.726456838564;1789.1143883777613;1828.743975843383;1850.3893715073993;1861.03226322313;1876.8029356917464;58883;61558.69220653868;61626.69186654083;61751.69124154351;62457.68771156115;9824.361416508047;9983.301168918251;10026.598936042623;10105.090541851268;10162.81499477601;13049.608511744664;13124.803127953088;13147.802782958262;13166.341682915816;13196;6886.311368863174;6993.720251189896;7007.194172670208;7075.39859111971;7130.679119439637;6762.69567869447;6766.357196066366;6772.356626120511;6803.523753337317;6804.489663275274;4343.131373725268;4359.476862776487;4362.585554372329;4375.299952007664;4392.253316936129;1738.7739593852718;1740.2082052666008;1795.5511122219445;1797.6563591719391;1811.6738986982207;848.2620120495209;897.392482221466;918.6371383303558;938.4603852784539;991.2268430623981;15201;15653;15937.123458209679;15979.680406391806;16256.837431625532;799.9040115186215;870.7997160652959;881.8853549038583;900.1358695652116;912.2519533982071;8822.470651760916;9095.135962083592;9134.862977055349;9233.307501937381;9634.614615415445;137988;391939;543565.079142879;544051;544753;77805.61097194478;77990;78749.60625196953;78967.60516197383;81379;1137.243732917617;1141.9371934543515;1145.7422080032093;1158.1082566423806;1165.8834116588444;15466.458673946358;15622.140782257085;15667.138307393203;15869.606292948169;15889.126098064717;32285.838570806995;32400.675993239765;33590.83204583961;33768;34313.828430857684;38905.805470973595;39659.2068158641;39851.60148398595;41055.79472102621;41870.371944421466;9093.272538197061;9094.363394562317;9267.073292670679;9274.44353338802;9583.185429238592;16612;16724.414645487348;16778.1610919456;17149.91425042867;17291.567710806827;14219.786703199667;14549;14555.781663275271;14877.851221487646;14898.329575168927;14115.505957291856;14210.431582736575;14404.42382304696;14795.778063329273;14981.101133932;11255.887441125484;11435.485403156712;14605.926970365505;14861.702765944838;15266.923665381602;8532.658693652433;8771.956140219258;9373.250139988648;9605.567749451151;9701.768593223456;10775.6228532001;13553.119047261896;13607.591772246848;13649.454021839016;13836.446542138605 05:22:49 INFO - PROCESS | 11622 | |3;mootools.html;1287.0411543400169;1432.3411230833813;1432.8423873373927;1562.1798555758226;1740.7998080220777;6727.428168605668;7298.708051677933;7418.629068546578;7420.295071968168;7433.739819106332;7320.450966177531;7495.962520187391;7515.624218789066;7523.962380188092;7546.320831125211;1970.1626808606286;2003.839692824578;2006.4482267376516;2214.8117410020127;2271.681964524968;1946.153423260879;2217.8891055447243;2237.2393386248673;2248.4378905273684;2248.7751224877543;2134.3063504361066;2143.9142434302607;2169.208238992764;2172.0660116150048;2176.5864485747657;2233.0063121910757;2271.375371772759;2273.9204127855446;2277.2029789573517;2277.555876604063;2203.5262418580082;2244.438890277431;2244.9887750561306;2250.7299124105048;2252.5044490212126;7450.2922222389325;7499.925000749977;7524.736634217831;7525.172231054579;7546.849063018709;4558.2251017327135;4611.031683346468;4615.815367385334;4644.907101857978;4647.512011238839;3084.8766049358;3092.304231547906;3128.3586864692684;3142.214446388403;3148.8740450381956;1014.6550172941162;1035.777307878802;1044.9164066874707;1075.9892401075967;1087.5921529426464;10347.741306467398;10354.482275886176;10372.429516376596;10377.221708371902;10397.948010259975;4097.733647312915;4137.172565486914;4181.038361176947;4190.224808410454;4191.517975432804;9001.18989290967;9005.729828105168;9010.144036316671;9015.188633023059;9029.819403611891;4645.39609850724;4657.441107067174;4665.113628410591;4671.602913752369;4679.789409476582;4136.069384388548;4137.689673274516;4138.441310423114;4168.24971505132;4176.9582304177175;3338.7329013678846;3628.310620982005;3634.2913131939017;3650.1604630935035;3691.3355595992443;1089.0525243038608;1096.380544992077;1097.434821067151;1182.479708928069;1193.1528614683498;1043.415687215162;1044.9373037617768;1085.766560189563;1200.5917987883986;1316.6708322919271;6608.107905432801;6633.635150066792;6641.900371494431;6679.398854103057;6703.631300278434;1070.68414817629;1079.1043433949803;1082.8105081610686;1102.6030628973563;1103.542030057533;5519.889602207933;5655.349634792052;5687.971560142173;5689.715514224355;5698.7435565399655;8218;8331.750047498585;8403.915960840435;8770.51762153075;9058.139476749699;8150.633221505046;8201.30288925436;8242;8267.710630127916;8276.710315139062;6862.245153033163;6939.757108501179;7036.261192574808;7062.611556364346;7063.293670632896;6877.759278425231;6957.373836354753;6981.3367730065565;6988.580685158907;7023.29767023314;7912.169222231582;7999.560024198725;8106.270435660819;8180.754577362689;8219.506829590244;7945.1657575953695;8067.798305042421;8068.717594884386;8078.878816817635;8352.081271060057;6522.119513865568;6560.40956313934;6676.365745254193;6713;6747.426468750211;7183.317584829433;7231.240719724564;7234.6020968847215;7253.891191632024;7266.7093316266755;6086.817395478142;6783.89824152648;6857;6949.339812717783;6954.756583519553;6430.871382572229;6730.730770769114;6743.5953842769595;6827.761028363983;6862.862742745017;6672.332766723289;6765.086713293643;6771.187457505131;6774.559653622498;6790.626515541692;6140.600860944203;6142.355052719578;6147.354527774519;6159.630422174684;6171.59884607499;6145.8156255312415;6243.344448832807;6342.49260059185;6346.270178929298;6373.681315934277 05:22:49 INFO - PROCESS | 11622 | |4;prototype.html;323.15656137481176;326.61133251430795;340.40259344849784;342.39396268604554;344.6105900332624;5844.912326315103;5868.237129173212;5875.970620146899;5892.3812999635065;5924.970375148129;5613.298337707786;5656.858578535539;5728.541716662668;5788.073908174693;5831.212786273852;4518.502964673883;4524.253498172798;4530.139273538034;4530.841420550273;4533.909321813562;4279.379489973968;4525.185466616008;4544.091181763644;4549.340345649879;4556.498785133633;4304.117655880553;4407.735535867842;4473.060657261979;4477.395551600541;4496.325551167319;4429.6899217054815;4451.198784218839;4457.24226881431;4477.104579084196;4499.257622492301;3998.04047028711;4014.2573623879675;4018.1361007383553;4020.778857162855;4022.979885100585;5418.647787893774;5523.116301391758;5548.472895074961;5566.137248726453;5578.330600327987;5272.472752724735;5280.894382112337;5283.233931079972;5289.894202115936;5293.020791153649;6162.5378096642935;6175.104609831549;6180.351063138396;6184.381561843825;6198.876022479571;4439.445069366329;4442.3336499525;4448.644108471314;4450.844220452269;4453.398791163184;6288.874222515524;6458.90311645321;6467.83830404239;6469.32072132424;6469.547131700783;4522.909541809146;4557.293619488984;4562.452505699337;4571.1086338164405;4572.862814115582;4619.145458090264;4638.814447422133;4642.396488456547;4642.675012749142;4644.442666879996;5264.263003179558;5267.3152490176035;5271.262023316739;5274.12976858814;5278.049951008778;6101.359357267512;6203.937960620336;6219.906701399483;6220.502359811204;6227.688615569204;1613.572403313123;1625.9024458532526;1627.9348826047062;1631.282235816237;1632.9793878825733;1106.6443606581872;1111.8499002634542;1126.5043380912373;1130.3444002478543;1143.108375467137;5894.440028197314;5900.262467191601;5912.763489460373;5915.37888521699;5915.822525324247;6350.968245158745;6357.841053973595;6363.268224154282;6379.170707807955;6382.329855365213;5697.515711164515;5785.82642520725;5837.29952405714;5951.464368206882;5970.044792833212;3444.9827750861086;3452.5684289463816;3464.047386968604;3471.4792781082533;3472.878449254264;6676.365745254193;6677.666116694146;6679.398854103057;6680.799576012728;6688.531802773857;6475.449586785176;6615.768448104293;6621;6623.105880706139;6629.303923088103;6666.83332916681;6673.099131617267;6678.83302917431;6682.933170668328;6689.966550167218;6405.871882562229;6406.423421892052;6411.6153030818305;6414.935850641434;6416.454601358937;6228.128062071223;6350.142730731292;6363.5863668861375;6376.4261216488885;6379.904301435575;6624.403803657694;6660.034295027097;6664.267290504406;6683.699233534406;6691.76578819739;4536.6143877770755;4540.795664195185;4543.045960348364;4549.499555049008;4553.203189441768;6310.274318453253;6399.744010239725;6423.743050277936;6427.0680751289865;6441.3880681335195;6223.751049957951;6246.281677606951;6246.781362652468;6270.0908368287255;6274.309825919054;6236.906446403398;6247.312795592572;6248.875022499616;6250.249970003629;6250.906236406367;6009.36901625323;6129.35641757609;6130.295016073031;6136.6806136680825;6152.261728592597;6288.874222515616;6291.402316779899;6293.307736149111;6304.401081897213;6305.180326557702;6093.969530152321;6124.173236613;6129.969350153221;6141.6007959482495;6146.231721034871 05:22:49 INFO - PROCESS | 11622 | |5;yui.html;738.4055835052782;832.5462622870535;840.2689659995805;847.1951645936362;850.6682393866391;13279.867201327985;13534.187948723084;13560.389782459788;13570.525031623894;13586.864131358683;12554.81167782484;12615.116941814076;12675;12679.302638354888;12689.428975696093;657.828964469239;792.885031670406;801.7394346837272;802.2659266770897;802.9879551806728;661.1438187547138;790.0045942112922;798.5089170160368;798.876174193001;798.9680412783482;844.2907957315854;854.0221446443818;857.6826574167567;860.3289434241302;862.2239984014375;699.0492929615718;705.474421555939;824.1922915542801;859.6647307550061;864.2394692670441;607.4927435591287;610.4810910725892;611.7736437518103;611.8439797851564;613.6348872420947;12263.080268979862;12308.569200077955;12326.445309960984;12437.253764774143;12500.24998500093;10435.217358698052;11011.28426652265;11355;11383.317000979885;11502.654920352403;10218.335808172445;10317.277790554665;10346.586136554528;10361.48192590375;10423.895761042368;3492.6332735062706;3512.1570823002553;3567.30437564675;3578.6600272974024;3581;46263.07473850538;46397.53602463966;46403.53596464026;46445.30332045022;46890.53109468896;9281.860772088425;9287.674931377505;9489.478078705599;9532.857007144898;9640.084192001748;17911;18099.72850407245;18101.094945252684;18124.184411701506;18126.456206313833;6718.865622687519;6912.447004239649;7037.049998250171;7091.92908070923;7224.988501609779;3823.636754508317;3833.0609000794984;3871.845126194977;3885.96114038856;3926.823292951824;2964.777641676883;3000.984995075011;3002.054352878836;3019.531972544259;3046.2688954650725;600.2676734384045;604.353341924137;606.7876243314893;619.8760247950428;620.271181361898;628.8019273928697;631.7567736421419;649.5842660697158;650.6291413894035;651.8989556618732;7219.8917016244795;7220.783376498714;7246.637668116573;7420.109586849612;7556.811079723051;542.7937383794133;627.4102343796816;644.8549076457854;647.7668039505775;651.8565915498583;3728.664420202195;3762.755420897633;3879.534455865314;3887.9939542191623;3922.7579623534625;51136.23295650568;53803.46196537984;54181.72909135508;54205;57180;45049.549504505194;47660.28509572359;47682.761586191846;47999.76000119977;48302.27546586804;44420.3336949946;44545.33182002272;50588.241176382384;50697.74651126721;51359;7962.852007189749;8180.918190818015;8241.587920603826;8329.750107496784;8476.110008449024;35374.46938295979;35418.8229058853;35509;35868.461973069905;36447.08882277858;39974.20051598894;42336.576634233264;44397.55602444064;44603;44663;10908.026764147127;11102.500387482743;11653.067754579783;11719.589814356457;11912;11708.594036629127;11909.583164589198;11929.343886086348;12148.331841748435;12521.561745339233;10535.42055186972;10730.463476826284;11009.559617615205;11197.888021119685;11223.438828058728;10444.268901177149;10675.447467134094;10784.568617255221;10875.293105948089;11118.888811111785;9686.70939871805;9894.901050989685;9941.105300522988;10033.297669163088;10204.795904082026;9463.810723785347;9599.32804703664;9599.568019439002;9650.806983860424;10449;8383.203595658402;8652.221300083023;8810.471371717718;8999.865002025106;9116.726498205064 05:22:49 INFO - PROCESS | 11622 | __end_tp_report 05:22:49 INFO - PROCESS | 11622 | __start_cc_report 05:22:49 INFO - PROCESS | 11622 | _x_x_mozilla_cycle_collect,894 05:22:49 INFO - PROCESS | 11622 | __end_cc_report 05:22:49 INFO - PROCESS | 11622 | __startTimestamp1452086569730__endTimestamp 05:22:49 INFO - PROCESS | 11622 | 05:22:49 INFO - PROCESS | 11622 | ------- Summary: start ------- 05:22:49 INFO - PROCESS | 11622 | Number of tests: 6 05:22:49 INFO - PROCESS | 11622 | 05:22:49 INFO - PROCESS | 11622 | [#0] dojo.html Cycles:165 Average:5106.76 Median:5226.56 stddev:543.40 (10.4%) stddev-sans-first:521.28 05:22:49 INFO - PROCESS | 11622 | Values: 3079.5 3150.1 3190.8 3198.3 3208.0 4935.6 5061.1 5095.8 5103.7 5138.5 4953.4 4995.8 5010.6 5013.5 5058.7 4450.1 4613.6 4636.9 4678.2 4806.7 4544.6 4617.2 4769.2 4769.4 4792.6 4567.8 4640.6 4644.8 4655.7 4658.5 4675.0 4693.4 4717.8 4723.2 4756.3 4461.2 4588.3 4710.4 4722.0 4729.3 4939.1 5001.4 5007.5 5008.2 5054.2 5484.9 5506.3 5513.8 5529.3 5560.3 5349.6 5474.8 5484.6 5536.6 5541.0 5156.7 5182.6 5188.6 5190.2 5200.8 5685.9 5751.9 5757.1 5765.8 5766.4 5230.4 5329.1 5334.5 5392.9 5523.4 5510.8 5541.8 5545.2 5594.3 5600.7 5508.4 5509.4 5512.1 5523.8 5529.7 5327.5 5428.3 5475.6 5527.9 5600.0 4289.8 4334.3 4366.9 4370.9 4376.0 3874.5 3894.1 3897.6 3927.8 3935.8 5006.2 5172.8 5213.1 5215.5 5225.5 5436.2 5479.0 5487.1 5589.6 5631.4 5183.7 5186.6 5187.4 5193.4 5225.3 4770.2 4777.5 4786.2 4794.0 4829.3 5477.8 5565.6 5623.6 5698.0 5706.8 5449.8 5513.3 5522.6 5566.0 5571.6 5660.3 5667.5 5668.0 5675.7 5678.9 5313.9 5382.1 5396.1 5409.9 5439.6 5339.4 5518.7 5579.8 5582.8 5601.6 5355.1 5360.6 5361.2 5361.8 5362.3 5207.2 5308.9 5322.5 5329.1 5384.8 5175.4 5222.7 5303.2 5320.3 5344.7 5305.9 5314.3 5341.3 5358.7 5395.0 5058.2 5208.0 5209.1 5211.3 5226.6 05:22:49 INFO - PROCESS | 11622 | 05:22:49 INFO - PROCESS | 11622 | [#1] ext.html Cycles:180 Average:45488.92 Median:34511.05 stddev:74109.39 (214.7%) stddev-sans-first:74240.38 05:22:49 INFO - PROCESS | 11622 | Values: 524.9 530.3 531.5 551.3 560.5 29076.1 29739.9 29773.1 36897.3 37696.8 40863.6 41209.6 41211.8 41213.0 41267.6 8401.1 8558.4 8561.3 8567.8 8569.0 7403.6 7522.2 10102.6 10298.2 10315.6 10128.5 10204.6 10236.5 10236.8 10241.2 7577.8 7731.1 9946.2 10084.0 10084.1 7231.5 7324.2 7325.6 10139.8 10354.2 37068.0 37510.0 37553.0 37576.2 37590.8 3174.7 3607.3 3612.2 3856.6 3932.4 28197.3 28656.9 29183.4 29244.4 30061.8 3945.0 4050.9 4056.3 4108.3 4147.3 259736.0 259963.0 262411.0 262744.7 262921.0 51522.0 52683.0 59893.7 60534.4 60552.4 64212.0 65118.3 65144.3 65157.7 65208.0 12305.0 12467.2 12527.2 12588.4 12604.1 10105.9 10126.8 10158.1 10164.2 10185.8 20099.3 20465.2 20509.6 20596.0 20747.5 7748.9 7833.8 7834.5 7919.0 7947.4 912.3 956.3 1034.3 1061.3 1070.7 28653.0 28885.0 28928.4 29276.0 29409.9 1004.7 1042.2 1104.7 1120.2 1180.3 14898.8 15144.2 15195.8 15424.6 15505.5 326125.0 329506.0 331027.0 333069.0 333151.0 51965.5 52192.5 52776.5 52808.5 52921.5 1347.5 1347.7 1348.4 1348.5 1354.7 27806.6 28522.4 29136.3 29150.3 29238.0 49467.0 50074.7 50218.0 50314.0 50412.7 250450.0 252165.0 252265.0 252310.0 253536.0 36021.0 36330.8 38870.6 42563.3 42966.4 38711.0 41812.2 42855.0 43348.1 43929.3 35944.0 36395.0 36534.3 37554.0 37704.2 29525.5 36222.3 37117.2 37375.8 37490.0 32455.5 33549.3 33984.5 34295.5 34320.6 33268.7 34701.5 35667.5 37463.6 37624.2 23579.6 23775.3 23867.0 24108.5 24249.6 05:22:49 INFO - PROCESS | 11622 | 05:22:49 INFO - PROCESS | 11622 | [#2] jquery.html Cycles:180 Average:25270.28 Median:2080.49 stddev:75682.99 (3637.7%) stddev-sans-first:75872.16 05:22:49 INFO - PROCESS | 11622 | Values: 346.3 356.9 358.5 358.5 359.1 14159.2 14454.3 16365.3 16628.5 17236.7 15680.3 15698.9 16252.8 16277.3 16305.1 4636.4 4808.8 4813.8 4816.6 4819.4 3801.9 3885.0 4787.4 5299.4 5512.4 5449.6 5459.2 5460.9 5472.8 5486.6 5370.6 5907.0 5919.2 5940.0 5964.3 5242.6 5278.4 5294.0 5298.0 5310.0 12338.9 13233.4 13248.1 13259.1 15515.7 1953.7 1996.8 2058.0 2063.5 2075.9 9451.0 9730.0 9782.3 10770.8 10941.7 1789.1 1828.7 1850.4 1861.0 1876.8 58883.0 61558.7 61626.7 61751.7 62457.7 9824.4 9983.3 10026.6 10105.1 10162.8 13049.6 13124.8 13147.8 13166.3 13196.0 6886.3 6993.7 7007.2 7075.4 7130.7 6762.7 6766.4 6772.4 6803.5 6804.5 4343.1 4359.5 4362.6 4375.3 4392.3 1738.8 1740.2 1795.6 1797.7 1811.7 848.3 897.4 918.6 938.5 991.2 15201.0 15653.0 15937.1 15979.7 16256.8 799.9 870.8 881.9 900.1 912.3 8822.5 9095.1 9134.9 9233.3 9634.6 137988.0 391939.0 543565.1 544051.0 544753.0 77805.6 77990.0 78749.6 78967.6 81379.0 1137.2 1141.9 1145.7 1158.1 1165.9 15466.5 15622.1 15667.1 15869.6 15889.1 32285.8 32400.7 33590.8 33768.0 34313.8 38905.8 39659.2 39851.6 41055.8 41870.4 9093.3 9094.4 9267.1 9274.4 9583.2 16612.0 16724.4 16778.2 17149.9 17291.6 14219.8 14549.0 14555.8 14877.9 14898.3 14115.5 14210.4 14404.4 14795.8 14981.1 11255.9 11435.5 14605.9 14861.7 15266.9 8532.7 8772.0 9373.3 9605.6 9701.8 10775.6 13553.1 13607.6 13649.5 13836.4 05:22:49 INFO - PROCESS | 11622 | 05:22:49 INFO - PROCESS | 11622 | [#3] mootools.html Cycles:180 Average:5236.73 Median:6113.71 stddev:2662.03 (43.5%) stddev-sans-first:2652.94 05:22:49 INFO - PROCESS | 11622 | Values: 1287.0 1432.3 1432.8 1562.2 1740.8 6727.4 7298.7 7418.6 7420.3 7433.7 7320.5 7496.0 7515.6 7524.0 7546.3 1970.2 2003.8 2006.4 2214.8 2271.7 1946.2 2217.9 2237.2 2248.4 2248.8 2134.3 2143.9 2169.2 2172.1 2176.6 2233.0 2271.4 2273.9 2277.2 2277.6 2203.5 2244.4 2245.0 2250.7 2252.5 7450.3 7499.9 7524.7 7525.2 7546.8 4558.2 4611.0 4615.8 4644.9 4647.5 3084.9 3092.3 3128.4 3142.2 3148.9 1014.7 1035.8 1044.9 1076.0 1087.6 10347.7 10354.5 10372.4 10377.2 10397.9 4097.7 4137.2 4181.0 4190.2 4191.5 9001.2 9005.7 9010.1 9015.2 9029.8 4645.4 4657.4 4665.1 4671.6 4679.8 4136.1 4137.7 4138.4 4168.2 4177.0 3338.7 3628.3 3634.3 3650.2 3691.3 1089.1 1096.4 1097.4 1182.5 1193.2 1043.4 1044.9 1085.8 1200.6 1316.7 6608.1 6633.6 6641.9 6679.4 6703.6 1070.7 1079.1 1082.8 1102.6 1103.5 5519.9 5655.3 5688.0 5689.7 5698.7 8218.0 8331.8 8403.9 8770.5 9058.1 8150.6 8201.3 8242.0 8267.7 8276.7 6862.2 6939.8 7036.3 7062.6 7063.3 6877.8 6957.4 6981.3 6988.6 7023.3 7912.2 7999.6 8106.3 8180.8 8219.5 7945.2 8067.8 8068.7 8078.9 8352.1 6522.1 6560.4 6676.4 6713.0 6747.4 7183.3 7231.2 7234.6 7253.9 7266.7 6086.8 6783.9 6857.0 6949.3 6954.8 6430.9 6730.7 6743.6 6827.8 6862.9 6672.3 6765.1 6771.2 6774.6 6790.6 6140.6 6142.4 6147.4 6159.6 6171.6 6145.8 6243.3 6342.5 6346.3 6373.7 05:22:49 INFO - PROCESS | 11622 | 05:22:49 INFO - PROCESS | 11622 | [#4] prototype.html Cycles:180 Average:5224.41 Median:5884.18 stddev:1547.24 (26.3%) stddev-sans-first:1507.22 05:22:49 INFO - PROCESS | 11622 | Values: 323.2 326.6 340.4 342.4 344.6 5844.9 5868.2 5876.0 5892.4 5925.0 5613.3 5656.9 5728.5 5788.1 5831.2 4518.5 4524.3 4530.1 4530.8 4533.9 4279.4 4525.2 4544.1 4549.3 4556.5 4304.1 4407.7 4473.1 4477.4 4496.3 4429.7 4451.2 4457.2 4477.1 4499.3 3998.0 4014.3 4018.1 4020.8 4023.0 5418.6 5523.1 5548.5 5566.1 5578.3 5272.5 5280.9 5283.2 5289.9 5293.0 6162.5 6175.1 6180.4 6184.4 6198.9 4439.4 4442.3 4448.6 4450.8 4453.4 6288.9 6458.9 6467.8 6469.3 6469.5 4522.9 4557.3 4562.5 4571.1 4572.9 4619.1 4638.8 4642.4 4642.7 4644.4 5264.3 5267.3 5271.3 5274.1 5278.0 6101.4 6203.9 6219.9 6220.5 6227.7 1613.6 1625.9 1627.9 1631.3 1633.0 1106.6 1111.8 1126.5 1130.3 1143.1 5894.4 5900.3 5912.8 5915.4 5915.8 6351.0 6357.8 6363.3 6379.2 6382.3 5697.5 5785.8 5837.3 5951.5 5970.0 3445.0 3452.6 3464.0 3471.5 3472.9 6676.4 6677.7 6679.4 6680.8 6688.5 6475.4 6615.8 6621.0 6623.1 6629.3 6666.8 6673.1 6678.8 6682.9 6690.0 6405.9 6406.4 6411.6 6414.9 6416.5 6228.1 6350.1 6363.6 6376.4 6379.9 6624.4 6660.0 6664.3 6683.7 6691.8 4536.6 4540.8 4543.0 4549.5 4553.2 6310.3 6399.7 6423.7 6427.1 6441.4 6223.8 6246.3 6246.8 6270.1 6274.3 6236.9 6247.3 6248.9 6250.2 6250.9 6009.4 6129.4 6130.3 6136.7 6152.3 6288.9 6291.4 6293.3 6304.4 6305.2 6094.0 6124.2 6130.0 6141.6 6146.2 05:22:49 INFO - PROCESS | 11622 | 05:22:49 INFO - PROCESS | 11622 | [#5] yui.html Cycles:180 Average:13325.20 Median:47275.41 stddev:15485.35 (32.8%) stddev-sans-first:15499.95 05:22:49 INFO - PROCESS | 11622 | Values: 738.4 832.5 840.3 847.2 850.7 13279.9 13534.2 13560.4 13570.5 13586.9 12554.8 12615.1 12675.0 12679.3 12689.4 657.8 792.9 801.7 802.3 803.0 661.1 790.0 798.5 798.9 799.0 844.3 854.0 857.7 860.3 862.2 699.0 705.5 824.2 859.7 864.2 607.5 610.5 611.8 611.8 613.6 12263.1 12308.6 12326.4 12437.3 12500.2 10435.2 11011.3 11355.0 11383.3 11502.7 10218.3 10317.3 10346.6 10361.5 10423.9 3492.6 3512.2 3567.3 3578.7 3581.0 46263.1 46397.5 46403.5 46445.3 46890.5 9281.9 9287.7 9489.5 9532.9 9640.1 17911.0 18099.7 18101.1 18124.2 18126.5 6718.9 6912.4 7037.0 7091.9 7225.0 3823.6 3833.1 3871.8 3886.0 3926.8 2964.8 3001.0 3002.1 3019.5 3046.3 600.3 604.4 606.8 619.9 620.3 628.8 631.8 649.6 650.6 651.9 7219.9 7220.8 7246.6 7420.1 7556.8 542.8 627.4 644.9 647.8 651.9 3728.7 3762.8 3879.5 3888.0 3922.8 51136.2 53803.5 54181.7 54205.0 57180.0 45049.5 47660.3 47682.8 47999.8 48302.3 44420.3 44545.3 50588.2 50697.7 51359.0 7962.9 8180.9 8241.6 8329.8 8476.1 35374.5 35418.8 35509.0 35868.5 36447.1 39974.2 42336.6 44397.6 44603.0 44663.0 10908.0 11102.5 11653.1 11719.6 11912.0 11708.6 11909.6 11929.3 12148.3 12521.6 10535.4 10730.5 11009.6 11197.9 11223.4 10444.3 10675.4 10784.6 10875.3 11118.9 9686.7 9894.9 9941.1 10033.3 10204.8 9463.8 9599.3 9599.6 9650.8 10449.0 8383.2 8652.2 8810.5 8999.9 9116.7 05:22:49 INFO - PROCESS | 11622 | -------- Summary: end -------- 05:22:49 INFO - PROCESS | 11622 | 05:22:50 INFO - TEST-INFO | 11622: exit 0 05:22:50 INFO - TEST-OK | dromaeo_css | took 1112300ms 05:22:50 INFO - TEST-START | kraken 05:22:50 INFO - operating with platform_type : linux_ 05:22:50 INFO - Initialising browser for kraken test... 05:22:50 INFO - TEST-INFO | started process 11815 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpI8y0lq/profile http://localhost:36128/getInfo.html) 05:22:54 INFO - PROCESS | 11815 | __metrics Screen width/height:1600/1200 05:22:54 INFO - PROCESS | 11815 | colorDepth:24 05:22:54 INFO - PROCESS | 11815 | Browser inner width/height: 1024/697 05:22:54 INFO - PROCESS | 11815 | __metrics 05:22:54 INFO - PROCESS | 11815 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:22:54 INFO - PROCESS | 11815 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:22:55 INFO - TEST-INFO | 11815: exit 0 05:22:55 INFO - Browser initialized. 05:22:55 INFO - Running cycle 1/1 for kraken test... 05:22:55 INFO - TEST-INFO | started process 11898 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpI8y0lq/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:23:07 INFO - PROCESS | 11898 | RSS: Main: 150286336 05:23:07 INFO - PROCESS | 11898 | 05:23:09 INFO - PROCESS | 11898 | Cycle 1(1): loaded http://localhost:36128/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36128/tests/kraken/driver.html?testName=audio-beat-detection) 05:23:10 INFO - PROCESS | 11898 | RSS: Main: 185135104 05:23:10 INFO - PROCESS | 11898 | 05:23:12 INFO - PROCESS | 11898 | Cycle 1(1): loaded http://localhost:36128/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36128/tests/kraken/driver.html?testName=audio-dft) 05:23:13 INFO - PROCESS | 11898 | RSS: Main: 173973504 05:23:13 INFO - PROCESS | 11898 | 05:23:16 INFO - PROCESS | 11898 | Cycle 1(1): loaded http://localhost:36128/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36128/tests/kraken/driver.html?testName=audio-fft) 05:23:16 INFO - PROCESS | 11898 | RSS: Main: 159514624 05:23:16 INFO - PROCESS | 11898 | 05:23:18 INFO - PROCESS | 11898 | Cycle 1(1): loaded http://localhost:36128/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36128/tests/kraken/driver.html?testName=audio-oscillator) 05:23:19 INFO - PROCESS | 11898 | RSS: Main: 163287040 05:23:19 INFO - PROCESS | 11898 | 05:23:21 INFO - PROCESS | 11898 | Cycle 1(1): loaded http://localhost:36128/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36128/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:23:22 INFO - PROCESS | 11898 | RSS: Main: 164687872 05:23:22 INFO - PROCESS | 11898 | 05:23:25 INFO - PROCESS | 11898 | Cycle 1(1): loaded http://localhost:36128/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36128/tests/kraken/driver.html?testName=imaging-darkroom) 05:23:25 INFO - PROCESS | 11898 | RSS: Main: 164089856 05:23:25 INFO - PROCESS | 11898 | 05:23:29 INFO - PROCESS | 11898 | Cycle 1(1): loaded http://localhost:36128/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36128/tests/kraken/driver.html?testName=imaging-desaturate) 05:23:29 INFO - PROCESS | 11898 | RSS: Main: 165515264 05:23:29 INFO - PROCESS | 11898 | 05:23:32 INFO - PROCESS | 11898 | Cycle 1(1): loaded http://localhost:36128/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36128/tests/kraken/driver.html?testName=json-parse-financial) 05:23:32 INFO - PROCESS | 11898 | RSS: Main: 164327424 05:23:32 INFO - PROCESS | 11898 | 05:23:34 INFO - PROCESS | 11898 | Cycle 1(1): loaded http://localhost:36128/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36128/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:23:35 INFO - PROCESS | 11898 | RSS: Main: 174379008 05:23:35 INFO - PROCESS | 11898 | 05:23:36 INFO - PROCESS | 11898 | Cycle 1(1): loaded http://localhost:36128/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36128/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:23:37 INFO - PROCESS | 11898 | RSS: Main: 173518848 05:23:37 INFO - PROCESS | 11898 | 05:23:39 INFO - PROCESS | 11898 | Cycle 1(1): loaded http://localhost:36128/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36128/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:23:40 INFO - PROCESS | 11898 | RSS: Main: 179417088 05:23:40 INFO - PROCESS | 11898 | 05:23:42 INFO - PROCESS | 11898 | Cycle 1(1): loaded http://localhost:36128/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36128/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:23:43 INFO - PROCESS | 11898 | RSS: Main: 187711488 05:23:43 INFO - PROCESS | 11898 | 05:23:45 INFO - PROCESS | 11898 | Cycle 1(1): loaded http://localhost:36128/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36128/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:23:46 INFO - PROCESS | 11898 | RSS: Main: 185245696 05:23:46 INFO - PROCESS | 11898 | 05:23:47 INFO - PROCESS | 11898 | Cycle 1(1): loaded http://localhost:36128/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36128/tests/kraken/driver.html?testName=ai-astar) 05:23:48 INFO - PROCESS | 11898 | RSS: Main: 243703808 05:23:48 INFO - PROCESS | 11898 | 05:23:48 INFO - PROCESS | 11898 | __start_tp_report 05:23:48 INFO - PROCESS | 11898 | _x_x_mozilla_page_load 05:23:48 INFO - PROCESS | 11898 | _x_x_mozilla_page_load_details 05:23:48 INFO - PROCESS | 11898 | |i|pagename|runs| 05:23:48 INFO - PROCESS | 11898 | |0;ai-astar;110;109;102;110;111;110;100;111;109;108 05:23:48 INFO - PROCESS | 11898 | |1;audio-beat-detection;151;131;156;163;129;150;151;128;172;123 05:23:48 INFO - PROCESS | 11898 | |2;audio-dft;163;159;160;161;162;161;160;165;162;163 05:23:48 INFO - PROCESS | 11898 | |3;audio-fft;73;71;95;99;74;71;71;94;95;72 05:23:48 INFO - PROCESS | 11898 | |4;audio-oscillator;97;98;139;96;96;98;145;97;98;143 05:23:48 INFO - PROCESS | 11898 | |5;imaging-gaussian-blur;110;109;109;109;110;110;109;110;110;109 05:23:48 INFO - PROCESS | 11898 | |6;imaging-darkroom;147;147;146;146;147;146;145;147;146;148 05:23:48 INFO - PROCESS | 11898 | |7;imaging-desaturate;96;97;97;97;95;96;97;96;96;96 05:23:48 INFO - PROCESS | 11898 | |8;json-parse-financial;58;60;60;59;58;61;60;59;57;57 05:23:48 INFO - PROCESS | 11898 | |9;json-stringify-tinderbox;68;68;68;68;68;68;68;68;68;68 05:23:48 INFO - PROCESS | 11898 | |10;stanford-crypto-aes;87;94;86;87;85;86;86;86;87;87 05:23:48 INFO - PROCESS | 11898 | |11;stanford-crypto-ccm;126;117;115;135;123;117;117;118;115;120 05:23:48 INFO - PROCESS | 11898 | |12;stanford-crypto-pbkdf2;162;149;150;150;157;138;151;150;149;140 05:23:48 INFO - PROCESS | 11898 | |13;stanford-crypto-sha256-iterative;68;69;69;67;69;71;68;68;68;68 05:23:48 INFO - PROCESS | 11898 | __end_tp_report 05:23:48 INFO - PROCESS | 11898 | __start_cc_report 05:23:48 INFO - PROCESS | 11898 | _x_x_mozilla_cycle_collect,981 05:23:48 INFO - PROCESS | 11898 | __end_cc_report 05:23:48 INFO - PROCESS | 11898 | __startTimestamp1452086628210__endTimestamp 05:23:48 INFO - PROCESS | 11898 | 05:23:48 INFO - PROCESS | 11898 | ------- Summary: start ------- 05:23:48 INFO - PROCESS | 11898 | Number of tests: 14 05:23:48 INFO - PROCESS | 11898 | 05:23:48 INFO - PROCESS | 11898 | [#0] ai-astar Cycles:10 Average:108.00 Median:110.00 stddev:3.83 (3.5%) stddev-sans-first:3.99 05:23:48 INFO - PROCESS | 11898 | Values: 110.0 109.0 102.0 110.0 111.0 110.0 100.0 111.0 109.0 108.0 05:23:48 INFO - PROCESS | 11898 | 05:23:48 INFO - PROCESS | 11898 | [#1] audio-beat-detection Cycles:10 Average:145.40 Median:151.00 stddev:16.65 (11.0%) stddev-sans-first:17.53 05:23:48 INFO - PROCESS | 11898 | Values: 151.0 131.0 156.0 163.0 129.0 150.0 151.0 128.0 172.0 123.0 05:23:48 INFO - PROCESS | 11898 | 05:23:48 INFO - PROCESS | 11898 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.78 (1.1%) stddev-sans-first:1.81 05:23:48 INFO - PROCESS | 11898 | Values: 163.0 159.0 160.0 161.0 162.0 161.0 160.0 165.0 162.0 163.0 05:23:48 INFO - PROCESS | 11898 | 05:23:48 INFO - PROCESS | 11898 | [#3] audio-fft Cycles:10 Average:81.50 Median:84.00 stddev:12.37 (14.7%) stddev-sans-first:12.73 05:23:48 INFO - PROCESS | 11898 | Values: 73.0 71.0 95.0 99.0 74.0 71.0 71.0 94.0 95.0 72.0 05:23:48 INFO - PROCESS | 11898 | 05:23:48 INFO - PROCESS | 11898 | [#4] audio-oscillator Cycles:10 Average:110.70 Median:97.00 stddev:21.89 (22.6%) stddev-sans-first:22.65 05:23:48 INFO - PROCESS | 11898 | Values: 97.0 98.0 139.0 96.0 96.0 98.0 145.0 97.0 98.0 143.0 05:23:48 INFO - PROCESS | 11898 | 05:23:48 INFO - PROCESS | 11898 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:23:48 INFO - PROCESS | 11898 | Values: 110.0 109.0 109.0 109.0 110.0 110.0 109.0 110.0 110.0 109.0 05:23:48 INFO - PROCESS | 11898 | 05:23:48 INFO - PROCESS | 11898 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 05:23:48 INFO - PROCESS | 11898 | Values: 147.0 147.0 146.0 146.0 147.0 146.0 145.0 147.0 146.0 148.0 05:23:48 INFO - PROCESS | 11898 | 05:23:48 INFO - PROCESS | 11898 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 05:23:48 INFO - PROCESS | 11898 | Values: 96.0 97.0 97.0 97.0 95.0 96.0 97.0 96.0 96.0 96.0 05:23:48 INFO - PROCESS | 11898 | 05:23:48 INFO - PROCESS | 11898 | [#8] json-parse-financial Cycles:10 Average:58.90 Median:59.50 stddev:1.37 (2.3%) stddev-sans-first:1.41 05:23:48 INFO - PROCESS | 11898 | Values: 58.0 60.0 60.0 59.0 58.0 61.0 60.0 59.0 57.0 57.0 05:23:48 INFO - PROCESS | 11898 | 05:23:48 INFO - PROCESS | 11898 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 05:23:48 INFO - PROCESS | 11898 | Values: 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 05:23:48 INFO - PROCESS | 11898 | 05:23:48 INFO - PROCESS | 11898 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:2.51 (2.9%) stddev-sans-first:2.67 05:23:48 INFO - PROCESS | 11898 | Values: 87.0 94.0 86.0 87.0 85.0 86.0 86.0 86.0 87.0 87.0 05:23:48 INFO - PROCESS | 11898 | 05:23:48 INFO - PROCESS | 11898 | [#11] stanford-crypto-ccm Cycles:10 Average:120.30 Median:119.00 stddev:6.24 (5.2%) stddev-sans-first:6.26 05:23:48 INFO - PROCESS | 11898 | Values: 126.0 117.0 115.0 135.0 123.0 117.0 117.0 118.0 115.0 120.0 05:23:48 INFO - PROCESS | 11898 | 05:23:48 INFO - PROCESS | 11898 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:150.00 stddev:6.98 (4.7%) stddev-sans-first:5.78 05:23:48 INFO - PROCESS | 11898 | Values: 162.0 149.0 150.0 150.0 157.0 138.0 151.0 150.0 149.0 140.0 05:23:48 INFO - PROCESS | 11898 | 05:23:48 INFO - PROCESS | 11898 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:1.08 (1.6%) stddev-sans-first:1.13 05:23:48 INFO - PROCESS | 11898 | Values: 68.0 69.0 69.0 67.0 69.0 71.0 68.0 68.0 68.0 68.0 05:23:48 INFO - PROCESS | 11898 | -------- Summary: end -------- 05:23:48 INFO - PROCESS | 11898 | 05:23:49 INFO - TEST-INFO | 11898: exit 0 05:23:49 INFO - TEST-OK | kraken | took 58651ms 05:23:49 INFO - TEST-START | v8_7 05:23:49 INFO - operating with platform_type : linux_ 05:23:49 INFO - Initialising browser for v8_7 test... 05:23:49 INFO - TEST-INFO | started process 12152 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVMyluW/profile http://localhost:36128/getInfo.html) 05:23:52 INFO - PROCESS | 12152 | __metrics Screen width/height:1600/1200 05:23:52 INFO - PROCESS | 12152 | colorDepth:24 05:23:52 INFO - PROCESS | 12152 | Browser inner width/height: 1024/697 05:23:52 INFO - PROCESS | 12152 | __metrics 05:23:53 INFO - PROCESS | 12152 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:23:53 INFO - PROCESS | 12152 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:23:53 INFO - PROCESS | 12152 | 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. 05:23:53 INFO - TEST-INFO | 12152: exit 0 05:23:53 INFO - Browser initialized. 05:23:53 INFO - Running cycle 1/1 for v8_7 test... 05:23:53 INFO - TEST-INFO | started process 12236 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpVMyluW/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:05 INFO - PROCESS | 12236 | RSS: Main: 147644416 05:24:05 INFO - PROCESS | 12236 | 05:24:27 INFO - PROCESS | 12236 | Cycle 1(1): loaded http://localhost:36128/tests/v8_7/run.html (next: http://localhost:36128/tests/v8_7/run.html) 05:24:27 INFO - PROCESS | 12236 | RSS: Main: 576659456 05:24:27 INFO - PROCESS | 12236 | 05:24:27 INFO - PROCESS | 12236 | __start_tp_report 05:24:27 INFO - PROCESS | 12236 | _x_x_mozilla_page_load 05:24:27 INFO - PROCESS | 12236 | _x_x_mozilla_page_load_details 05:24:27 INFO - PROCESS | 12236 | |i|pagename|runs| 05:24:27 INFO - PROCESS | 12236 | |0;Richards;168.09547823163558 05:24:27 INFO - PROCESS | 12236 | |1;DeltaBlue;197.58940920766648 05:24:27 INFO - PROCESS | 12236 | |2;Encrypt;285.30670470756064 05:24:27 INFO - PROCESS | 12236 | |3;Decrypt;5186.5284974093265 05:24:27 INFO - PROCESS | 12236 | |4;RayTrace;1974.3589743589744 05:24:27 INFO - PROCESS | 12236 | |5;Earley;813.6696501220505 05:24:27 INFO - PROCESS | 12236 | |6;Boyer;12353.658536585366 05:24:27 INFO - PROCESS | 12236 | |7;RegExp;28305.555555555555 05:24:27 INFO - PROCESS | 12236 | |8;Splay;657.4621959237344 05:24:27 INFO - PROCESS | 12236 | |9;NavierStokes;4854.368932038835 05:24:27 INFO - PROCESS | 12236 | __end_tp_report 05:24:27 INFO - PROCESS | 12236 | __startTimestamp1452086667507__endTimestamp 05:24:27 INFO - PROCESS | 12236 | 05:24:27 INFO - PROCESS | 12236 | ------- Summary: start ------- 05:24:27 INFO - PROCESS | 12236 | Number of tests: 10 05:24:27 INFO - PROCESS | 12236 | 05:24:27 INFO - PROCESS | 12236 | [#0] Richards Cycles:1 Average:168.10 Median:168.10 stddev:0.00 (0.0%) 05:24:27 INFO - PROCESS | 12236 | Values: 168.1 05:24:27 INFO - PROCESS | 12236 | 05:24:27 INFO - PROCESS | 12236 | [#1] DeltaBlue Cycles:1 Average:197.59 Median:197.59 stddev:0.00 (0.0%) 05:24:27 INFO - PROCESS | 12236 | Values: 197.6 05:24:27 INFO - PROCESS | 12236 | 05:24:27 INFO - PROCESS | 12236 | [#2] Encrypt Cycles:1 Average:285.31 Median:285.31 stddev:0.00 (0.0%) 05:24:27 INFO - PROCESS | 12236 | Values: 285.3 05:24:27 INFO - PROCESS | 12236 | 05:24:27 INFO - PROCESS | 12236 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 05:24:27 INFO - PROCESS | 12236 | Values: 5186.5 05:24:27 INFO - PROCESS | 12236 | 05:24:27 INFO - PROCESS | 12236 | [#4] RayTrace Cycles:1 Average:1974.36 Median:1974.36 stddev:0.00 (0.0%) 05:24:27 INFO - PROCESS | 12236 | Values: 1974.4 05:24:27 INFO - PROCESS | 12236 | 05:24:27 INFO - PROCESS | 12236 | [#5] Earley Cycles:1 Average:813.67 Median:813.67 stddev:0.00 (0.0%) 05:24:27 INFO - PROCESS | 12236 | Values: 813.7 05:24:27 INFO - PROCESS | 12236 | 05:24:27 INFO - PROCESS | 12236 | [#6] Boyer Cycles:1 Average:12353.66 Median:12353.66 stddev:0.00 (0.0%) 05:24:27 INFO - PROCESS | 12236 | Values: 12353.7 05:24:27 INFO - PROCESS | 12236 | 05:24:27 INFO - PROCESS | 12236 | [#7] RegExp Cycles:1 Average:28305.56 Median:28305.56 stddev:0.00 (0.0%) 05:24:27 INFO - PROCESS | 12236 | Values: 28305.6 05:24:27 INFO - PROCESS | 12236 | 05:24:27 INFO - PROCESS | 12236 | [#8] Splay Cycles:1 Average:657.46 Median:657.46 stddev:0.00 (0.0%) 05:24:27 INFO - PROCESS | 12236 | Values: 657.5 05:24:27 INFO - PROCESS | 12236 | 05:24:27 INFO - PROCESS | 12236 | [#9] NavierStokes Cycles:1 Average:4854.37 Median:4854.37 stddev:0.00 (0.0%) 05:24:27 INFO - PROCESS | 12236 | Values: 4854.4 05:24:27 INFO - PROCESS | 12236 | -------- Summary: end -------- 05:24:27 INFO - PROCESS | 12236 | 05:24:28 INFO - TEST-INFO | 12236: exit 0 05:24:28 INFO - TEST-OK | v8_7 | took 39228ms 05:24:28 INFO - SUITE-END | took 1210s 05:24:28 INFO - Completed test suite (00:20:10) 05:24:28 INFO - Working with test: dromaeo_css 05:24:28 INFO - Generating results file: dromaeo_css 05:24:28 INFO - Working with test: kraken 05:24:28 INFO - Generating results file: kraken 05:24:28 INFO - javascript benchmark 05:24:28 INFO - Working with test: v8_7 05:24:28 INFO - Generating results file: v8_7 05:24:28 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:24:28 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 05:24:28 INFO - process_Request line: dromaeo_css 6800.31 graph.html#tests=[[72,64,35]] 05:24:28 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:24:28 INFO - process_Request line: kraken 1511.90 graph.html#tests=[[232,64,35]] 05:24:28 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:24:28 INFO - process_Request line: v8_7 19274.55 graph.html#tests=[[230,64,35]] 05:24:28 INFO - RETURN: dromaeo_css: 6800.31 05:24:28 INFO - RETURN: kraken: 1511.90 05:24:28 INFO - RETURN: v8_7: 19274.55 05:24:28 INFO - javascript benchmark 05:24:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3079.4610943084963, 3150.086474922273, 3190.8404579771022, 3198.2803869129434, 3208.0, 4935.580475659564, 5061.139606266935, 5095.847124586259, 5103.744812759361, 5138.460461651524, 4953.3560637117125, 4995.800167993276, 5010.599152067835, 5013.498650134985, 5058.69647821131, 4450.132224216279, 4613.6078433333205, 4636.907261854761, 4678.1813182692895, 4806.687565308262, 4544.636429085665, 4617.191991401508, 4769.18923782956, 4769.356136921523, 4792.616590672737, 4567.794449249792, 4640.60554852838, 4644.814207431698, 4655.720656760588, 4658.464276608166, 4674.953250467486, 4693.389859318267, 4717.811287548494, 4723.197056500403, 4756.334113224151, 4461.24158892989, 4588.2888152336445, 4710.3641008463765, 4722.031983443386, 4729.314249433813, 4939.061578300148, 5001.3998320201445, 5007.549320561167, 5008.198688209905, 5054.1660625996665, 5484.890302193974, 5506.256655351516, 5513.8345849624575, 5529.30883639545, 5560.277163968699, 5349.5720342372515, 5474.835754927359, 5484.61607687462, 5536.557075433956, 5541.0, 5156.664816786934, 5182.585393168538, 5188.558972487343, 5190.195519694454, 5200.817971370984, 5685.914711279334, 5751.942480575224, 5757.050086735725, 5765.818007308491, 5766.4233576642, 5230.37235531731, 5329.067413202674, 5334.51989320963, 5392.892142157135, 5523.392426833045, 5510.779568817203, 5541.833744987657, 5545.195946587723, 5594.300712410949, 5600.663960162403, 5508.394076651565, 5509.3664228613425, 5512.145617429305, 5523.834284971457, 5529.668219906818, 5327.467253274719, 5428.348598168245, 5475.616706830484, 5527.889442211133, 5599.972000140055, 4289.785510724451, 4334.349847522897, 4366.890827729332, 4370.890727731832, 4376.0, 3874.49631547897, 3894.1043559981363, 3897.61023897608, 3927.7839718815167, 3935.8032098394965, 5006.224035274538, 5172.844814655567, 5213.139831927765, 5215.452377500384, 5225.503577160163, 5436.157395603688, 5479.04116779562, 5487.122060470306, 5589.552835773128, 5631.436856314336, 5183.714895680699, 5186.559142472856, 5187.403448603459, 5193.3767947845745, 5225.346831646044, 4770.212914869077, 4777.546133117348, 4786.1863483207935, 4794.041191761662, 4829.323894654751, 5477.835664930059, 5565.554755619541, 5623.550115990793, 5698.031334673115, 5706.828795136153, 5449.836504904859, 5513.283273174462, 5522.5858060644805, 5565.998120338216, 5571.60998730085, 5660.29246344207, 5667.546596272371, 5668.0, 5675.7445914933105, 5678.914816277676, 5313.9468605315, 5382.111951527954, 5396.055690254111, 5409.891802163856, 5439.646422982493, 5339.4126646068125, 5518.668879867221, 5579.8047068354035, 5582.804601838916, 5601.607887448003, 5355.062863998863, 5360.571154307568, 5361.195820626937, 5361.785528578969, 5362.302900622894, 5207.1668533036045, 5308.893822123613, 5322.494363035506, 5329.094054010905, 5384.838454846361, 5175.430702622783, 5222.7127507987425, 5303.151495760814, 5320.334958130234, 5344.6525975813, 5305.859240263362, 5314.3091398117995, 5341.278927344759, 5358.678479291255, 5395.0, 5058.215976523645, 5208.0365132450615, 5209.140491818807, 5211.348581427322, 5226.555742761908], "unit": "score", "name": "dojo.html", "value": 5073.714603879329}, {"lowerIsBetter": false, "replicates": [524.9212618107284, 530.284116442802, 531.529596307268, 551.2723205368914, 560.5039540007092, 29076.127716168496, 29739.851300743492, 29773.106806795804, 36897.26205475889, 37696.81151594245, 40863.59136408635, 41209.58790412095, 41211.79394103033, 41213.0, 41267.58732412675, 8401.075881653029, 8558.400911936136, 8561.272291855168, 8567.828643427129, 8568.957155214215, 7403.592802395866, 7522.2101679323705, 10102.59589616418, 10298.17614590831, 10315.638952636658, 10128.54421551032, 10204.591816327375, 10236.539355728974, 10236.795264094713, 10241.231907606922, 7577.772666820004, 7731.149573546962, 9946.15457686094, 10084.042016008467, 10084.092431681183, 7231.529950553249, 7324.1577218620005, 7325.560466372035, 10139.79720405595, 10354.17166626668, 37068.0, 37510.0, 37553.0, 37576.24847503062, 37590.812045939594, 3174.68253174683, 3607.314610224049, 3612.187257866985, 3856.5564960029674, 3932.390479475686, 28197.295067623472, 28656.856715716498, 29183.41633167346, 29244.415111697646, 30061.849690751624, 3945.0, 4050.9189816203807, 4056.3104272273786, 4108.26051310764, 4147.274227010261, 259736.0, 259963.0, 262411.0, 262744.6862765693, 262921.0, 51522.0, 52683.0, 59893.70053149707, 60534.39465605376, 60552.39447605467, 64212.0, 65118.34881651123, 65144.34855651478, 65157.67421162864, 65208.0, 12305.0, 12467.189632673848, 12527.248365098123, 12588.370581471074, 12604.11771176009, 10105.9494702526, 10126.848097278547, 10158.085772280383, 10164.237682173867, 10185.847212291821, 20099.29652462186, 20465.18139274442, 20509.58980820405, 20596.0, 20747.481312966996, 7748.92251077482, 7833.764987050397, 7834.4907581007055, 7919.0, 7947.410517896444, 912.2838571721167, 956.3401253135314, 1034.2915103154364, 1061.2889364126054, 1070.6895000449938, 28653.0, 28885.0, 28928.421431571252, 29276.0, 29409.852950735538, 1004.6785028790863, 1042.2339580408393, 1104.6685994201707, 1120.2438354110943, 1180.2682336950973, 14898.776518352233, 15144.16707081121, 15195.772063419057, 15424.614384640474, 15505.457308994131, 326125.0, 329506.0, 331027.0, 333069.0, 333151.0, 51965.48034519606, 52192.47807521952, 52776.47223527792, 52808.47191528112, 52921.470785291654, 1347.5081595217675, 1347.7304539092024, 1348.4067010515341, 1348.5187255450019, 1354.674878029266, 27806.582901256093, 28522.42955140927, 29136.27159321034, 29150.27124321824, 29238.0, 49467.0, 50074.74962625309, 50218.0, 50314.0, 50412.747936260086, 250450.0, 252165.0, 252265.0, 252310.0, 253536.0, 36021.0, 36330.818345908105, 38870.6112938867, 42563.29746810093, 42966.355504666826, 38711.0, 41812.163756725306, 42855.0, 43348.13303733845, 43929.34105988477, 35944.0, 36395.0, 36534.269314613026, 37554.0, 37704.245915082094, 29525.47981140391, 36222.275554489286, 37117.20077448931, 37375.813120934225, 37490.0, 32455.513167302983, 33549.322533873696, 33984.490232646036, 34295.48556771601, 34320.627174912726, 33268.66731332656, 34701.47947780735, 35667.46498802572, 37463.62536374601, 37624.24751505009, 23579.64630530509, 23775.286741397787, 23867.0, 24108.51782964366, 24249.63625545583], "unit": "score", "name": "ext.html", "value": 18436.73358553451}, {"lowerIsBetter": false, "replicates": [346.27801034842355, 356.8768774772702, 358.46230654018973, 358.54643875497493, 359.05926472641653, 14159.22124283164, 14454.277286135704, 16365.345386184554, 16628.50114496564, 17236.74144887826, 15680.294386752596, 15698.921505392456, 16252.75620865688, 16277.348906043744, 16305.103219322933, 4636.350910872472, 4808.759562021903, 4813.78337974792, 4816.566509014188, 4819.42166939966, 3801.923961520768, 3885.0, 4787.449443314012, 5299.417064122943, 5512.39363669996, 5449.6375906023495, 5459.235707001023, 5460.945390546083, 5472.781088756445, 5486.561075114001, 5370.570354371641, 5907.0, 5919.200907877467, 5940.04959206527, 5964.254468191476, 5242.580593552507, 5278.392984806758, 5294.0, 5297.973510132463, 5310.0441920454305, 12338.876611233862, 13233.404496797668, 13248.138870973356, 13259.138156019828, 15515.68116710081, 1953.7460130183126, 1996.8103030212108, 2057.9794202057938, 2063.546019875625, 2075.865068770525, 9451.0, 9729.951350243204, 9782.315237933348, 10770.784584308349, 10941.726456838564, 1789.1143883777613, 1828.743975843383, 1850.3893715073993, 1861.03226322313, 1876.8029356917464, 58883.0, 61558.69220653868, 61626.69186654083, 61751.69124154351, 62457.68771156115, 9824.361416508047, 9983.301168918251, 10026.598936042623, 10105.090541851268, 10162.81499477601, 13049.608511744664, 13124.803127953088, 13147.802782958262, 13166.341682915816, 13196.0, 6886.311368863174, 6993.720251189896, 7007.194172670208, 7075.39859111971, 7130.679119439637, 6762.69567869447, 6766.357196066366, 6772.356626120511, 6803.523753337317, 6804.489663275274, 4343.131373725268, 4359.476862776487, 4362.585554372329, 4375.299952007664, 4392.253316936129, 1738.7739593852718, 1740.2082052666008, 1795.5511122219445, 1797.6563591719391, 1811.6738986982207, 848.2620120495209, 897.392482221466, 918.6371383303558, 938.4603852784539, 991.2268430623981, 15201.0, 15653.0, 15937.123458209679, 15979.680406391806, 16256.837431625532, 799.9040115186215, 870.7997160652959, 881.8853549038583, 900.1358695652116, 912.2519533982071, 8822.470651760916, 9095.135962083592, 9134.862977055349, 9233.307501937381, 9634.614615415445, 137988.0, 391939.0, 543565.079142879, 544051.0, 544753.0, 77805.61097194478, 77990.0, 78749.60625196953, 78967.60516197383, 81379.0, 1137.243732917617, 1141.9371934543515, 1145.7422080032093, 1158.1082566423806, 1165.8834116588444, 15466.458673946358, 15622.140782257085, 15667.138307393203, 15869.606292948169, 15889.126098064717, 32285.838570806995, 32400.675993239765, 33590.83204583961, 33768.0, 34313.828430857684, 38905.805470973595, 39659.2068158641, 39851.60148398595, 41055.79472102621, 41870.371944421466, 9093.272538197061, 9094.363394562317, 9267.073292670679, 9274.44353338802, 9583.185429238592, 16612.0, 16724.414645487348, 16778.1610919456, 17149.91425042867, 17291.567710806827, 14219.786703199667, 14549.0, 14555.781663275271, 14877.851221487646, 14898.329575168927, 14115.505957291856, 14210.431582736575, 14404.42382304696, 14795.778063329273, 14981.101133932, 11255.887441125484, 11435.485403156712, 14605.926970365505, 14861.702765944838, 15266.923665381602, 8532.658693652433, 8771.956140219258, 9373.250139988648, 9605.567749451151, 9701.768593223456, 10775.6228532001, 13553.119047261896, 13607.591772246848, 13649.454021839016, 13836.446542138605], "unit": "score", "name": "jquery.html", "value": 8483.090606018637}, {"lowerIsBetter": false, "replicates": [1287.0411543400169, 1432.3411230833813, 1432.8423873373927, 1562.1798555758226, 1740.7998080220777, 6727.428168605668, 7298.708051677933, 7418.629068546578, 7420.295071968168, 7433.739819106332, 7320.450966177531, 7495.962520187391, 7515.624218789066, 7523.962380188092, 7546.320831125211, 1970.1626808606286, 2003.839692824578, 2006.4482267376516, 2214.8117410020127, 2271.681964524968, 1946.153423260879, 2217.8891055447243, 2237.2393386248673, 2248.4378905273684, 2248.7751224877543, 2134.3063504361066, 2143.9142434302607, 2169.208238992764, 2172.0660116150048, 2176.5864485747657, 2233.0063121910757, 2271.375371772759, 2273.9204127855446, 2277.2029789573517, 2277.555876604063, 2203.5262418580082, 2244.438890277431, 2244.9887750561306, 2250.7299124105048, 2252.5044490212126, 7450.2922222389325, 7499.925000749977, 7524.736634217831, 7525.172231054579, 7546.849063018709, 4558.2251017327135, 4611.031683346468, 4615.815367385334, 4644.907101857978, 4647.512011238839, 3084.8766049358, 3092.304231547906, 3128.3586864692684, 3142.214446388403, 3148.8740450381956, 1014.6550172941162, 1035.777307878802, 1044.9164066874707, 1075.9892401075967, 1087.5921529426464, 10347.741306467398, 10354.482275886176, 10372.429516376596, 10377.221708371902, 10397.948010259975, 4097.733647312915, 4137.172565486914, 4181.038361176947, 4190.224808410454, 4191.517975432804, 9001.18989290967, 9005.729828105168, 9010.144036316671, 9015.188633023059, 9029.819403611891, 4645.39609850724, 4657.441107067174, 4665.113628410591, 4671.602913752369, 4679.789409476582, 4136.069384388548, 4137.689673274516, 4138.441310423114, 4168.24971505132, 4176.9582304177175, 3338.7329013678846, 3628.310620982005, 3634.2913131939017, 3650.1604630935035, 3691.3355595992443, 1089.0525243038608, 1096.380544992077, 1097.434821067151, 1182.479708928069, 1193.1528614683498, 1043.415687215162, 1044.9373037617768, 1085.766560189563, 1200.5917987883986, 1316.6708322919271, 6608.107905432801, 6633.635150066792, 6641.900371494431, 6679.398854103057, 6703.631300278434, 1070.68414817629, 1079.1043433949803, 1082.8105081610686, 1102.6030628973563, 1103.542030057533, 5519.889602207933, 5655.349634792052, 5687.971560142173, 5689.715514224355, 5698.7435565399655, 8218.0, 8331.750047498585, 8403.915960840435, 8770.51762153075, 9058.139476749699, 8150.633221505046, 8201.30288925436, 8242.0, 8267.710630127916, 8276.710315139062, 6862.245153033163, 6939.757108501179, 7036.261192574808, 7062.611556364346, 7063.293670632896, 6877.759278425231, 6957.373836354753, 6981.3367730065565, 6988.580685158907, 7023.29767023314, 7912.169222231582, 7999.560024198725, 8106.270435660819, 8180.754577362689, 8219.506829590244, 7945.1657575953695, 8067.798305042421, 8068.717594884386, 8078.878816817635, 8352.081271060057, 6522.119513865568, 6560.40956313934, 6676.365745254193, 6713.0, 6747.426468750211, 7183.317584829433, 7231.240719724564, 7234.6020968847215, 7253.891191632024, 7266.7093316266755, 6086.817395478142, 6783.89824152648, 6857.0, 6949.339812717783, 6954.756583519553, 6430.871382572229, 6730.730770769114, 6743.5953842769595, 6827.761028363983, 6862.862742745017, 6672.332766723289, 6765.086713293643, 6771.187457505131, 6774.559653622498, 6790.626515541692, 6140.600860944203, 6142.355052719578, 6147.354527774519, 6159.630422174684, 6171.59884607499, 6145.8156255312415, 6243.344448832807, 6342.49260059185, 6346.270178929298, 6373.681315934277], "unit": "score", "name": "mootools.html", "value": 4332.632363896283}, {"lowerIsBetter": false, "replicates": [323.15656137481176, 326.61133251430795, 340.40259344849784, 342.39396268604554, 344.6105900332624, 5844.912326315103, 5868.237129173212, 5875.970620146899, 5892.3812999635065, 5924.970375148129, 5613.298337707786, 5656.858578535539, 5728.541716662668, 5788.073908174693, 5831.212786273852, 4518.502964673883, 4524.253498172798, 4530.139273538034, 4530.841420550273, 4533.909321813562, 4279.379489973968, 4525.185466616008, 4544.091181763644, 4549.340345649879, 4556.498785133633, 4304.117655880553, 4407.735535867842, 4473.060657261979, 4477.395551600541, 4496.325551167319, 4429.6899217054815, 4451.198784218839, 4457.24226881431, 4477.104579084196, 4499.257622492301, 3998.04047028711, 4014.2573623879675, 4018.1361007383553, 4020.778857162855, 4022.979885100585, 5418.647787893774, 5523.116301391758, 5548.472895074961, 5566.137248726453, 5578.330600327987, 5272.472752724735, 5280.894382112337, 5283.233931079972, 5289.894202115936, 5293.020791153649, 6162.5378096642935, 6175.104609831549, 6180.351063138396, 6184.381561843825, 6198.876022479571, 4439.445069366329, 4442.3336499525, 4448.644108471314, 4450.844220452269, 4453.398791163184, 6288.874222515524, 6458.90311645321, 6467.83830404239, 6469.32072132424, 6469.547131700783, 4522.909541809146, 4557.293619488984, 4562.452505699337, 4571.1086338164405, 4572.862814115582, 4619.145458090264, 4638.814447422133, 4642.396488456547, 4642.675012749142, 4644.442666879996, 5264.263003179558, 5267.3152490176035, 5271.262023316739, 5274.12976858814, 5278.049951008778, 6101.359357267512, 6203.937960620336, 6219.906701399483, 6220.502359811204, 6227.688615569204, 1613.572403313123, 1625.9024458532526, 1627.9348826047062, 1631.282235816237, 1632.9793878825733, 1106.6443606581872, 1111.8499002634542, 1126.5043380912373, 1130.3444002478543, 1143.108375467137, 5894.440028197314, 5900.262467191601, 5912.763489460373, 5915.37888521699, 5915.822525324247, 6350.968245158745, 6357.841053973595, 6363.268224154282, 6379.170707807955, 6382.329855365213, 5697.515711164515, 5785.82642520725, 5837.29952405714, 5951.464368206882, 5970.044792833212, 3444.9827750861086, 3452.5684289463816, 3464.047386968604, 3471.4792781082533, 3472.878449254264, 6676.365745254193, 6677.666116694146, 6679.398854103057, 6680.799576012728, 6688.531802773857, 6475.449586785176, 6615.768448104293, 6621.0, 6623.105880706139, 6629.303923088103, 6666.83332916681, 6673.099131617267, 6678.83302917431, 6682.933170668328, 6689.966550167218, 6405.871882562229, 6406.423421892052, 6411.6153030818305, 6414.935850641434, 6416.454601358937, 6228.128062071223, 6350.142730731292, 6363.5863668861375, 6376.4261216488885, 6379.904301435575, 6624.403803657694, 6660.034295027097, 6664.267290504406, 6683.699233534406, 6691.76578819739, 4536.6143877770755, 4540.795664195185, 4543.045960348364, 4549.499555049008, 4553.203189441768, 6310.274318453253, 6399.744010239725, 6423.743050277936, 6427.0680751289865, 6441.3880681335195, 6223.751049957951, 6246.281677606951, 6246.781362652468, 6270.0908368287255, 6274.309825919054, 6236.906446403398, 6247.312795592572, 6248.875022499616, 6250.249970003629, 6250.906236406367, 6009.36901625323, 6129.35641757609, 6130.295016073031, 6136.6806136680825, 6152.261728592597, 6288.874222515616, 6291.402316779899, 6293.307736149111, 6304.401081897213, 6305.180326557702, 6093.969530152321, 6124.173236613, 6129.969350153221, 6141.6007959482495, 6146.231721034871], "unit": "score", "name": "prototype.html", "value": 4727.426047155994}, {"lowerIsBetter": false, "replicates": [738.4055835052782, 832.5462622870535, 840.2689659995805, 847.1951645936362, 850.6682393866391, 13279.867201327985, 13534.187948723084, 13560.389782459788, 13570.525031623894, 13586.864131358683, 12554.81167782484, 12615.116941814076, 12675.0, 12679.302638354888, 12689.428975696093, 657.828964469239, 792.885031670406, 801.7394346837272, 802.2659266770897, 802.9879551806728, 661.1438187547138, 790.0045942112922, 798.5089170160368, 798.876174193001, 798.9680412783482, 844.2907957315854, 854.0221446443818, 857.6826574167567, 860.3289434241302, 862.2239984014375, 699.0492929615718, 705.474421555939, 824.1922915542801, 859.6647307550061, 864.2394692670441, 607.4927435591287, 610.4810910725892, 611.7736437518103, 611.8439797851564, 613.6348872420947, 12263.080268979862, 12308.569200077955, 12326.445309960984, 12437.253764774143, 12500.24998500093, 10435.217358698052, 11011.28426652265, 11355.0, 11383.317000979885, 11502.654920352403, 10218.335808172445, 10317.277790554665, 10346.586136554528, 10361.48192590375, 10423.895761042368, 3492.6332735062706, 3512.1570823002553, 3567.30437564675, 3578.6600272974024, 3581.0, 46263.07473850538, 46397.53602463966, 46403.53596464026, 46445.30332045022, 46890.53109468896, 9281.860772088425, 9287.674931377505, 9489.478078705599, 9532.857007144898, 9640.084192001748, 17911.0, 18099.72850407245, 18101.094945252684, 18124.184411701506, 18126.456206313833, 6718.865622687519, 6912.447004239649, 7037.049998250171, 7091.92908070923, 7224.988501609779, 3823.636754508317, 3833.0609000794984, 3871.845126194977, 3885.96114038856, 3926.823292951824, 2964.777641676883, 3000.984995075011, 3002.054352878836, 3019.531972544259, 3046.2688954650725, 600.2676734384045, 604.353341924137, 606.7876243314893, 619.8760247950428, 620.271181361898, 628.8019273928697, 631.7567736421419, 649.5842660697158, 650.6291413894035, 651.8989556618732, 7219.8917016244795, 7220.783376498714, 7246.637668116573, 7420.109586849612, 7556.811079723051, 542.7937383794133, 627.4102343796816, 644.8549076457854, 647.7668039505775, 651.8565915498583, 3728.664420202195, 3762.755420897633, 3879.534455865314, 3887.9939542191623, 3922.7579623534625, 51136.23295650568, 53803.46196537984, 54181.72909135508, 54205.0, 57180.0, 45049.549504505194, 47660.28509572359, 47682.761586191846, 47999.76000119977, 48302.27546586804, 44420.3336949946, 44545.33182002272, 50588.241176382384, 50697.74651126721, 51359.0, 7962.852007189749, 8180.918190818015, 8241.587920603826, 8329.750107496784, 8476.110008449024, 35374.46938295979, 35418.8229058853, 35509.0, 35868.461973069905, 36447.08882277858, 39974.20051598894, 42336.576634233264, 44397.55602444064, 44603.0, 44663.0, 10908.026764147127, 11102.500387482743, 11653.067754579783, 11719.589814356457, 11912.0, 11708.594036629127, 11909.583164589198, 11929.343886086348, 12148.331841748435, 12521.561745339233, 10535.42055186972, 10730.463476826284, 11009.559617615205, 11197.888021119685, 11223.438828058728, 10444.268901177149, 10675.447467134094, 10784.568617255221, 10875.293105948089, 11118.888811111785, 9686.70939871805, 9894.901050989685, 9941.105300522988, 10033.297669163088, 10204.795904082026, 9463.810723785347, 9599.32804703664, 9599.568019439002, 9650.806983860424, 10449.0, 8383.203595658402, 8652.221300083023, 8810.471371717718, 8999.865002025106, 9116.726498205064], "unit": "score", "name": "yui.html", "value": 6084.042344962127}], "name": "dromaeo_css", "value": 6800.313411099246}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 102.0, 110.0, 111.0, 110.0, 100.0, 111.0, 109.0, 108.0], "unit": "score", "name": "ai-astar", "value": 108.0}, {"lowerIsBetter": true, "replicates": [151.0, 131.0, 156.0, 163.0, 129.0, 150.0, 151.0, 128.0, 172.0, 123.0], "unit": "score", "name": "audio-beat-detection", "value": 145.4}, {"lowerIsBetter": true, "replicates": [163.0, 159.0, 160.0, 161.0, 162.0, 161.0, 160.0, 165.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 95.0, 99.0, 74.0, 71.0, 71.0, 94.0, 95.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 139.0, 96.0, 96.0, 98.0, 145.0, 97.0, 98.0, 143.0], "unit": "score", "name": "audio-oscillator", "value": 110.7}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 145.0, 147.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 97.0, 95.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [58.0, 60.0, 60.0, 59.0, 58.0, 61.0, 60.0, 59.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [87.0, 94.0, 86.0, 87.0, 85.0, 86.0, 86.0, 86.0, 87.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [126.0, 117.0, 115.0, 135.0, 123.0, 117.0, 117.0, 118.0, 115.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.3}, {"lowerIsBetter": true, "replicates": [162.0, 149.0, 150.0, 150.0, 157.0, 138.0, 151.0, 150.0, 149.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 67.0, 69.0, 71.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1511.8999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.09547823163558], "unit": "score", "name": "Richards", "value": 210.01159799999994}, {"lowerIsBetter": false, "replicates": [197.58940920766648], "unit": "score", "name": "DeltaBlue", "value": 334.62319799999995}, {"lowerIsBetter": false, "replicates": [285.30670470756064], "unit": "score", "name": "Encrypt", "value": 932.9644049999997}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1974.3589743589744], "unit": "score", "name": "RayTrace", "value": 374.7996233766234}, {"lowerIsBetter": false, "replicates": [813.6696501220505], "unit": "score", "name": "Earley", "value": 819.0830269999999}, {"lowerIsBetter": false, "replicates": [12353.658536585366], "unit": "score", "name": "Boyer", "value": 53.948633761105626}, {"lowerIsBetter": false, "replicates": [28305.555555555555], "unit": "score", "name": "RegExp", "value": 32.18396467124632}, {"lowerIsBetter": false, "replicates": [657.4621959237344], "unit": "score", "name": "Splay", "value": 123.94781100000004}, {"lowerIsBetter": false, "replicates": [4854.368932038835], "unit": "score", "name": "NavierStokes", "value": 305.7040000000001}], "name": "v8_7", "value": 19274.554096185886}]} 05:24:28 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "19274.55"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1511.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6800.31"}}} 05:24:28 INFO - Return code: 0 05:24:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:24:28 INFO - # TBPL SUCCESS # 05:24:28 INFO - Running post-action listener: _resource_record_post_action 05:24:28 INFO - Running post-run listener: _resource_record_post_run 05:24:29 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 563277824; Read time: 0; Write time: 511972 05:24:29 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 253841408; Read time: 0; Write time: 269120 05:24:29 INFO - run-tests - Wall time: 1212s; CPU: 13.0%; Read bytes: 0; Write bytes: 309436416; Read time: 0; Write time: 242852 05:24:29 INFO - Running post-run listener: _upload_blobber_files 05:24:29 INFO - Blob upload gear active. 05:24:29 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:24:29 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:24:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:24:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:24:30 INFO - (blobuploader) - INFO - Open directory for files ... 05:24:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:24:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:24:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:31 INFO - (blobuploader) - INFO - Done attempting. 05:24:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:24:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:24:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:24:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:24:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:24:32 INFO - (blobuploader) - INFO - Done attempting. 05:24:32 INFO - (blobuploader) - INFO - Iteration through files over. 05:24:32 INFO - Return code: 0 05:24:32 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:24:32 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:24:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2e1bf25f2aeb5845e270ebb215599a9f673e124d8cffc9f4264e1ef4243d869195e3fee01835e328ab14dcbb9a003847eb484be327ac906a342840abeaf3508", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1f3b5cee1608ec50a2c8d67f2131780425ba0a56ddc5cc4f8c01637370dd99030471c3995d78a7ac4672c266bdf682e9869be7d6ce6fdeb9d32b8c618b07da7"} 05:24:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:24:32 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:24:32 INFO - Contents: 05:24:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2e1bf25f2aeb5845e270ebb215599a9f673e124d8cffc9f4264e1ef4243d869195e3fee01835e328ab14dcbb9a003847eb484be327ac906a342840abeaf3508", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1f3b5cee1608ec50a2c8d67f2131780425ba0a56ddc5cc4f8c01637370dd99030471c3995d78a7ac4672c266bdf682e9869be7d6ce6fdeb9d32b8c618b07da7"} 05:24:32 INFO - Copying logs to upload dir... 05:24:32 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1266.443624 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-01-06 05:24:31.924821) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 05:24:31.928463) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2e1bf25f2aeb5845e270ebb215599a9f673e124d8cffc9f4264e1ef4243d869195e3fee01835e328ab14dcbb9a003847eb484be327ac906a342840abeaf3508", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1f3b5cee1608ec50a2c8d67f2131780425ba0a56ddc5cc4f8c01637370dd99030471c3995d78a7ac4672c266bdf682e9869be7d6ce6fdeb9d32b8c618b07da7"} build_url:https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011241 build_url: 'https://queue.taskcluster.net/v1/task/L4wUew64Toi-9H6tiEoAyw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2e1bf25f2aeb5845e270ebb215599a9f673e124d8cffc9f4264e1ef4243d869195e3fee01835e328ab14dcbb9a003847eb484be327ac906a342840abeaf3508", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c1f3b5cee1608ec50a2c8d67f2131780425ba0a56ddc5cc4f8c01637370dd99030471c3995d78a7ac4672c266bdf682e9869be7d6ce6fdeb9d32b8c618b07da7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-06 05:24:31.953818) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:24:31.954158) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1452083027.535661-843127511 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004702 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-06 05:24:32.040365) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 05:24:32.040723) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-06 05:24:32.041075) ========= ========= Total master_lag: 0.26 =========